builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-076 starttime: 1490662644.81 results: success (0) revision: 5182b2c4b963ed87d038c7d9a4021463917076cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:24.812245) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:24.812942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:24.813347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:24.826904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:24.827570) ========= 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=9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 17:57:25-- 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% 217M=0s 2017-03-27 17:57:25 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131084 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:24.970729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:24.971104) ========= 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=9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019301 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:25.022423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 17:57:25.022950) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5182b2c4b963ed87d038c7d9a4021463917076cd --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 5182b2c4b963ed87d038c7d9a4021463917076cd --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=9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 17:57:25,826 truncating revision to first 12 chars 2017-03-27 17:57:25,826 Setting DEBUG logging. 2017-03-27 17:57:25,826 attempt 1/10 2017-03-27 17:57:25,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5182b2c4b963?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 17:57:26,945 unpacking tar archive at: mozilla-central-5182b2c4b963/testing/mozharness/ program finished with exit code 0 elapsedTime=1.423062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 17:57:26.460091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:26.460414) ========= script_repo_revision: 5182b2c4b963ed87d038c7d9a4021463917076cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:26.460806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:26.461124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 17:57:26.471044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-03-27 17:57:26.471394) ========= /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=9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:57:27 INFO - MultiFileLogger online at 20170327 17:57:27 in /builds/slave/test 17:57:27 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 17:57:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:57:27 INFO - {'append_to_log': False, 17:57:27 INFO - 'base_work_dir': '/builds/slave/test', 17:57:27 INFO - 'blob_upload_branch': 'Firefox', 17:57:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:57:27 INFO - 'branch': 'Firefox', 17:57:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:57:27 INFO - 'config_files': ('talos/linux_config.py',), 17:57:27 INFO - 'default_actions': ('clobber', 17:57:27 INFO - 'read-buildbot-config', 17:57:27 INFO - 'download-and-extract', 17:57:27 INFO - 'populate-webroot', 17:57:27 INFO - 'create-virtualenv', 17:57:27 INFO - 'install', 17:57:27 INFO - 'run-tests'), 17:57:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:57:27 INFO - 'download_minidump_stackwalk': True, 17:57:27 INFO - 'download_symbols': 'ondemand', 17:57:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:57:27 INFO - 'tooltool.py': '/tools/tooltool.py', 17:57:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:57:27 INFO - '/tools/misc-python/virtualenv.py')}, 17:57:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:57:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:57:27 INFO - 'gecko_profile': False, 17:57:27 INFO - 'gecko_profile_interval': 0, 17:57:27 INFO - 'installer_path': 'installer.exe', 17:57:27 INFO - 'log_level': 'info', 17:57:27 INFO - 'log_name': 'talos', 17:57:27 INFO - 'log_to_console': True, 17:57:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:57:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:57:27 INFO - 'opt_config_files': (), 17:57:27 INFO - 'pip_index': False, 17:57:27 INFO - 'suite': 'dromaeojs', 17:57:27 INFO - 'system_bits': '32', 17:57:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:57:27 INFO - 'title': 'talos-linux64-ix-076', 17:57:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:57:27 INFO - 'use_talos_json': True, 17:57:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:57:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:57:27 INFO - 'work_dir': 'build'} 17:57:27 INFO - [mozharness: 2017-03-28 00:57:27.377312Z] Running clobber step. 17:57:27 INFO - Running pre-action listener: _resource_record_pre_action 17:57:27 INFO - Running main action method: clobber 17:57:27 INFO - rmtree: /builds/slave/test/build 17:57:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:57:28 INFO - Running post-action listener: _resource_record_post_action 17:57:28 INFO - [mozharness: 2017-03-28 00:57:28.388545Z] Finished clobber step (success) 17:57:28 INFO - [mozharness: 2017-03-28 00:57:28.388645Z] Running read-buildbot-config step. 17:57:28 INFO - Running pre-action listener: _resource_record_pre_action 17:57:28 INFO - Running main action method: read_buildbot_config 17:57:28 INFO - Using buildbot properties: 17:57:28 INFO - { 17:57:28 INFO - "project": "", 17:57:28 INFO - "product": "firefox", 17:57:28 INFO - "who": "kwierso@gmail.com", 17:57:28 INFO - "installer_path": "public/build/target.tar.bz2", 17:57:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 17:57:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:57:28 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 17:57:28 INFO - "stage_platform": "linux64-stylo", 17:57:28 INFO - "basedir": "/builds/slave/test", 17:57:28 INFO - "buildnumber": 0, 17:57:28 INFO - "platform": "ubuntu64_hw_stylo", 17:57:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:57:28 INFO - "slavebuilddir": "test", 17:57:28 INFO - "taskId": "eSVAvtO6TS-Uu8-s7zo4xw", 17:57:28 INFO - "branch": "mozilla-central", 17:57:28 INFO - "script_repo_revision": "production", 17:57:28 INFO - "revision": "5182b2c4b963ed87d038c7d9a4021463917076cd", 17:57:28 INFO - "slavename": "talos-linux64-ix-076", 17:57:28 INFO - "repo_path": "mozilla-central" 17:57:28 INFO - } 17:57:28 INFO - Finding installer, test and symbols from parent task. 17:57:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSVAvtO6TS-Uu8-s7zo4xw'}, attempt #1 17:57:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSVAvtO6TS-Uu8-s7zo4xw'}, attempt #1 17:57:29 INFO - Task dependencies: IGW5s5OtTaWhZoL7elDjAQ 17:57:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ'}, attempt #1 17:57:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2 17:57:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/test_packages.json 17:57:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.crashreporter-symbols.zip 17:57:29 INFO - Running post-action listener: _resource_record_post_action 17:57:29 INFO - [mozharness: 2017-03-28 00:57:29.766486Z] Finished read-buildbot-config step (success) 17:57:29 INFO - [mozharness: 2017-03-28 00:57:29.766702Z] Running download-and-extract step. 17:57:29 INFO - Running pre-action listener: _resource_record_pre_action 17:57:29 INFO - Running main action method: download_and_extract 17:57:29 INFO - mkdir: /builds/slave/test/build/tests 17:57:29 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')]} 17:57:29 INFO - trying https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.test_packages.json 17:57:29 INFO - Downloading https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:57:30 INFO - Downloaded 986 bytes. 17:57:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:57:30 INFO - Using the following test package requirements: 17:57:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:57:30 INFO - u'common': [u'target.common.tests.zip'], 17:57:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:57:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:57:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:57:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:57:30 INFO - u'mozbase': [u'target.common.tests.zip'], 17:57:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:57:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:57:30 INFO - u'web-platform': [u'target.common.tests.zip', 17:57:30 INFO - u'target.web-platform.tests.zip'], 17:57:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:57:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:57:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.common.tests.zip 17:57:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:57:30 INFO - Fetch https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.common.tests.zip into memory 17:57:31 INFO - Expected file size: 58225138 17:57:31 INFO - Obtained file size: 58225138 17:57:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:57:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.common.tests.zip 17:57:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:57:41 INFO - Fetch https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.common.tests.zip into memory 17:57:42 INFO - Expected file size: 58225138 17:57:42 INFO - Obtained file size: 58225138 17:57:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.talos.tests.zip 17:57:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:57:53 INFO - Fetch https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.talos.tests.zip into memory 17:57:54 INFO - Expected file size: 14404171 17:57:54 INFO - Obtained file size: 14404171 17:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:54 INFO - trying https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2 17:57:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:57:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:57:55 INFO - Downloaded 63827676 bytes. 17:57:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2 17:57:55 INFO - mkdir: /builds/slave/test/properties 17:57:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:57:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:57:55 INFO - Contents: 17:57:55 INFO - build_url:https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2 17:57:55 INFO - Running post-action listener: _resource_record_post_action 17:57:55 INFO - Running post-action listener: set_extra_try_arguments 17:57:55 INFO - [mozharness: 2017-03-28 00:57:55.476994Z] Finished download-and-extract step (success) 17:57:55 INFO - [mozharness: 2017-03-28 00:57:55.477091Z] Running populate-webroot step. 17:57:55 INFO - Running pre-action listener: _resource_record_pre_action 17:57:55 INFO - Running main action method: populate_webroot 17:57:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:57:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:57:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:57:55 INFO - '--tppagecycles', 17:57:55 INFO - '7'], 17:57:55 INFO - 'tests': ['tsvgm']}}, 17:57:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:57:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:57:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:57:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:57:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:57:55 INFO - 'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:57:55 INFO - 'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['damp', 'tps']}, 17:57:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:57:55 INFO - 'tests': ['damp', 'tps']}, 17:57:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['dromaeo_dom']}, 17:57:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:57:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['basic_compositor_video']}, 17:57:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:57:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['a11yr', 17:57:55 INFO - 'ts_paint', 17:57:55 INFO - 'tpaint', 17:57:55 INFO - 'sessionrestore', 17:57:55 INFO - 'sessionrestore_no_auto_restore', 17:57:55 INFO - 'tabpaint']}, 17:57:55 INFO - 'other-e10s': {'tests': ['a11yr', 17:57:55 INFO - 'ts_paint', 17:57:55 INFO - 'tpaint', 17:57:55 INFO - 'sessionrestore', 17:57:55 INFO - 'sessionrestore_no_auto_restore', 17:57:55 INFO - 'tabpaint']}, 17:57:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:57:55 INFO - 'ts_paint', 17:57:55 INFO - 'tpaint', 17:57:55 INFO - 'sessionrestore', 17:57:55 INFO - 'sessionrestore_no_auto_restore', 17:57:55 INFO - 'tabpaint']}, 17:57:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:57:55 INFO - 'ts_paint', 17:57:55 INFO - 'tpaint', 17:57:55 INFO - 'sessionrestore', 17:57:55 INFO - 'sessionrestore_no_auto_restore', 17:57:55 INFO - 'tabpaint']}, 17:57:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['a11yr', 17:57:55 INFO - 'ts_paint', 17:57:55 INFO - 'tpaint', 17:57:55 INFO - 'sessionrestore', 17:57:55 INFO - 'sessionrestore_no_auto_restore', 17:57:55 INFO - 'tabpaint']}, 17:57:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['a11yr', 17:57:55 INFO - 'ts_paint', 17:57:55 INFO - 'tpaint', 17:57:55 INFO - 'sessionrestore', 17:57:55 INFO - 'sessionrestore_no_auto_restore', 17:57:55 INFO - 'tabpaint']}, 17:57:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['tsvgx', 17:57:55 INFO - 'tsvgr_opacity', 17:57:55 INFO - 'tart', 17:57:55 INFO - 'tscrollx', 17:57:55 INFO - 'cart', 17:57:55 INFO - 'tsvg_static']}, 17:57:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:57:55 INFO - 'tsvgr_opacity', 17:57:55 INFO - 'tart', 17:57:55 INFO - 'tscrollx', 17:57:55 INFO - 'cart', 17:57:55 INFO - 'tsvg_static']}, 17:57:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:57:55 INFO - 'talos_options': ['--disable-e10s'], 17:57:55 INFO - 'tests': ['tp5o']}, 17:57:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:57:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:57:55 INFO - 'talos_options': ['--disable-e10s', 17:57:55 INFO - '--xperf_path', 17:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:55 INFO - 'tests': ['tp5n']}, 17:57:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:57:55 INFO - 'talos_options': ['--xperf_path', 17:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:55 INFO - 'tests': ['tp5n']}}, 17:57:55 INFO - 'talos.zip': {'path': '', 17:57:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:57:55 INFO - Running post-action listener: _resource_record_post_action 17:57:55 INFO - [mozharness: 2017-03-28 00:57:55.490162Z] Finished populate-webroot step (success) 17:57:55 INFO - [mozharness: 2017-03-28 00:57:55.490252Z] Running create-virtualenv step. 17:57:55 INFO - Running pre-action listener: _resource_record_pre_action 17:57:55 INFO - Running main action method: create_virtualenv 17:57:55 INFO - Creating virtualenv /builds/slave/test/build/venv 17:57:55 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 17:57:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:57:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:57:55 INFO - Using real prefix '/usr' 17:57:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:56 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:58 INFO - Installing pip.................done. 17:57:58 INFO - Return code: 0 17:57:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:57:58 INFO - Reading from file tmpfile_stdout 17:57:58 INFO - Output received: 17:57:58 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) 17:57:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:58 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:57:58 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 17:57:58 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 17:57:58 INFO - Using env: {'DISPLAY': ':0', 17:57:58 INFO - 'HOME': '/home/cltbld', 17:57:58 INFO - 'LANG': 'en_US.UTF-8', 17:57:58 INFO - 'LANGUAGE': 'en_US:en', 17:57:58 INFO - 'LOGNAME': 'cltbld', 17:57:58 INFO - 'MAIL': '/var/mail/cltbld', 17:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:58 INFO - 'MOZ_NO_REMOTE': '1', 17:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:58 INFO - 'NO_EM_RESTART': '1', 17:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:58 INFO - 'PWD': '/builds/slave/test', 17:57:58 INFO - 'SHELL': '/bin/bash', 17:57:58 INFO - 'SHLVL': '1', 17:57:58 INFO - 'TERM': 'linux', 17:57:58 INFO - 'TMOUT': '86400', 17:57:58 INFO - 'USER': 'cltbld', 17:57:58 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:58 INFO - '_': '/tools/buildbot/bin/python'} 17:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:58 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 17:57:58 INFO - Cleaning up... 17:57:58 INFO - Return code: 0 17:57:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:58 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:57:58 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 17:57:58 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 17:57:58 INFO - Using env: {'DISPLAY': ':0', 17:57:58 INFO - 'HOME': '/home/cltbld', 17:57:58 INFO - 'LANG': 'en_US.UTF-8', 17:57:58 INFO - 'LANGUAGE': 'en_US:en', 17:57:58 INFO - 'LOGNAME': 'cltbld', 17:57:58 INFO - 'MAIL': '/var/mail/cltbld', 17:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:58 INFO - 'MOZ_NO_REMOTE': '1', 17:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:58 INFO - 'NO_EM_RESTART': '1', 17:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:58 INFO - 'PWD': '/builds/slave/test', 17:57:58 INFO - 'SHELL': '/bin/bash', 17:57:58 INFO - 'SHLVL': '1', 17:57:58 INFO - 'TERM': 'linux', 17:57:58 INFO - 'TMOUT': '86400', 17:57:58 INFO - 'USER': 'cltbld', 17:57:58 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:58 INFO - '_': '/tools/buildbot/bin/python'} 17:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:58 INFO - Downloading/unpacking psutil>=3.1.1 17:57:58 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 17:57:58 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 17:57:58 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 17:57:58 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 17:57:58 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 17:57:58 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 17:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:00 INFO - Installing collected packages: psutil 17:58:00 INFO - Running setup.py install for psutil 17:58:00 INFO - building 'psutil._psutil_linux' extension 17:58:00 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 17:58:01 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 17:58:01 INFO - building 'psutil._psutil_posix' extension 17:58:01 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 17:58:01 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 17:58:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:01 INFO - Successfully installed psutil 17:58:01 INFO - Cleaning up... 17:58:01 INFO - Return code: 0 17:58:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:01 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58:01 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 17:58:01 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 17:58:01 INFO - Using env: {'DISPLAY': ':0', 17:58:01 INFO - 'HOME': '/home/cltbld', 17:58:01 INFO - 'LANG': 'en_US.UTF-8', 17:58:01 INFO - 'LANGUAGE': 'en_US:en', 17:58:01 INFO - 'LOGNAME': 'cltbld', 17:58:01 INFO - 'MAIL': '/var/mail/cltbld', 17:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:01 INFO - 'MOZ_NO_REMOTE': '1', 17:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:01 INFO - 'NO_EM_RESTART': '1', 17:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:01 INFO - 'PWD': '/builds/slave/test', 17:58:01 INFO - 'SHELL': '/bin/bash', 17:58:01 INFO - 'SHLVL': '1', 17:58:01 INFO - 'TERM': 'linux', 17:58:01 INFO - 'TMOUT': '86400', 17:58:01 INFO - 'USER': 'cltbld', 17:58:01 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:01 INFO - '_': '/tools/buildbot/bin/python'} 17:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:58:01 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 17:58:01 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 17:58:01 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 17:58:01 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 17:58:01 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 17:58:01 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 17:58:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:58:03 INFO - Installing collected packages: mozsystemmonitor 17:58:03 INFO - Running setup.py install for mozsystemmonitor 17:58:03 INFO - Successfully installed mozsystemmonitor 17:58:03 INFO - Cleaning up... 17:58:03 INFO - Return code: 0 17:58:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:58:03 INFO - Using env: {'DISPLAY': ':0', 17:58:03 INFO - 'HOME': '/home/cltbld', 17:58:03 INFO - 'LANG': 'en_US.UTF-8', 17:58:03 INFO - 'LANGUAGE': 'en_US:en', 17:58:03 INFO - 'LOGNAME': 'cltbld', 17:58:03 INFO - 'MAIL': '/var/mail/cltbld', 17:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:03 INFO - 'MOZ_NO_REMOTE': '1', 17:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:03 INFO - 'NO_EM_RESTART': '1', 17:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:03 INFO - 'PWD': '/builds/slave/test', 17:58:03 INFO - 'SHELL': '/bin/bash', 17:58:03 INFO - 'SHLVL': '1', 17:58:03 INFO - 'TERM': 'linux', 17:58:03 INFO - 'TMOUT': '86400', 17:58:03 INFO - 'USER': 'cltbld', 17:58:03 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:03 INFO - '_': '/tools/buildbot/bin/python'} 17:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:04 INFO - Downloading/unpacking jsonschema==2.5.1 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:58:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58:06 INFO - Downloading functools32-3.2.3-2.tar.gz 17:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:58:06 INFO - warning: no files found matching '*.txt' 17:58:06 INFO - no previously-included directories found matching 'build' 17:58:06 INFO - no previously-included directories found matching 'dist' 17:58:06 INFO - no previously-included directories found matching '.git*' 17:58:06 INFO - Installing collected packages: jsonschema, functools32 17:58:06 INFO - Running setup.py install for functools32 17:58:06 INFO - warning: no files found matching '*.txt' 17:58:06 INFO - no previously-included directories found matching 'build' 17:58:06 INFO - no previously-included directories found matching 'dist' 17:58:06 INFO - no previously-included directories found matching '.git*' 17:58:06 INFO - Successfully installed jsonschema functools32 17:58:06 INFO - Cleaning up... 17:58:06 INFO - Return code: 0 17:58:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:58:06 INFO - Using env: {'DISPLAY': ':0', 17:58:06 INFO - 'HOME': '/home/cltbld', 17:58:06 INFO - 'LANG': 'en_US.UTF-8', 17:58:06 INFO - 'LANGUAGE': 'en_US:en', 17:58:06 INFO - 'LOGNAME': 'cltbld', 17:58:06 INFO - 'MAIL': '/var/mail/cltbld', 17:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:06 INFO - 'MOZ_NO_REMOTE': '1', 17:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:06 INFO - 'NO_EM_RESTART': '1', 17:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:06 INFO - 'PWD': '/builds/slave/test', 17:58:06 INFO - 'SHELL': '/bin/bash', 17:58:06 INFO - 'SHLVL': '1', 17:58:06 INFO - 'TERM': 'linux', 17:58:06 INFO - 'TMOUT': '86400', 17:58:06 INFO - 'USER': 'cltbld', 17:58:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:06 INFO - '_': '/tools/buildbot/bin/python'} 17:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:58:06 INFO - Cleaning up... 17:58:06 INFO - Return code: 0 17:58:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:58:06 INFO - Using env: {'DISPLAY': ':0', 17:58:06 INFO - 'HOME': '/home/cltbld', 17:58:06 INFO - 'LANG': 'en_US.UTF-8', 17:58:06 INFO - 'LANGUAGE': 'en_US:en', 17:58:06 INFO - 'LOGNAME': 'cltbld', 17:58:06 INFO - 'MAIL': '/var/mail/cltbld', 17:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:06 INFO - 'MOZ_NO_REMOTE': '1', 17:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:06 INFO - 'NO_EM_RESTART': '1', 17:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:06 INFO - 'PWD': '/builds/slave/test', 17:58:06 INFO - 'SHELL': '/bin/bash', 17:58:06 INFO - 'SHLVL': '1', 17:58:06 INFO - 'TERM': 'linux', 17:58:06 INFO - 'TMOUT': '86400', 17:58:06 INFO - 'USER': 'cltbld', 17:58:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:06 INFO - '_': '/tools/buildbot/bin/python'} 17:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:58:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:58:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58: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 17:58:09 INFO - Downloading docopt-0.6.1.tar.gz 17:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:58:09 INFO - Installing collected packages: blobuploader, requests, docopt 17:58:09 INFO - Running setup.py install for blobuploader 17:58:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:58:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:58:09 INFO - Running setup.py install for requests 17:58:10 INFO - Running setup.py install for docopt 17:58:10 INFO - Successfully installed blobuploader requests docopt 17:58:10 INFO - Cleaning up... 17:58:10 INFO - Return code: 0 17:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58: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')]} 17:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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')]} 17:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58: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 17:58: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 17:58:10 INFO - Using env: {'DISPLAY': ':0', 17:58:10 INFO - 'HOME': '/home/cltbld', 17:58:10 INFO - 'LANG': 'en_US.UTF-8', 17:58:10 INFO - 'LANGUAGE': 'en_US:en', 17:58:10 INFO - 'LOGNAME': 'cltbld', 17:58:10 INFO - 'MAIL': '/var/mail/cltbld', 17:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:10 INFO - 'MOZ_NO_REMOTE': '1', 17:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:10 INFO - 'NO_EM_RESTART': '1', 17:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:10 INFO - 'PWD': '/builds/slave/test', 17:58:10 INFO - 'SHELL': '/bin/bash', 17:58:10 INFO - 'SHLVL': '1', 17:58:10 INFO - 'TERM': 'linux', 17:58:10 INFO - 'TMOUT': '86400', 17:58:10 INFO - 'USER': 'cltbld', 17:58:10 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:10 INFO - '_': '/tools/buildbot/bin/python'} 17:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:10 INFO - Running setup.py (path:/tmp/pip-lsWpre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:10 INFO - Running setup.py (path:/tmp/pip-6Xg6cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:10 INFO - Running setup.py (path:/tmp/pip-zjrQ9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:10 INFO - Running setup.py (path:/tmp/pip-rw1LiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:11 INFO - Running setup.py (path:/tmp/pip-sTyq3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:11 INFO - Running setup.py (path:/tmp/pip-dZGrs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:11 INFO - Running setup.py (path:/tmp/pip-QELpMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:11 INFO - Running setup.py (path:/tmp/pip-E8HOei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:11 INFO - Running setup.py (path:/tmp/pip-n73ukl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:11 INFO - Running setup.py (path:/tmp/pip-j11B6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:11 INFO - Running setup.py (path:/tmp/pip-23KJsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:11 INFO - Running setup.py (path:/tmp/pip-jDl6OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:11 INFO - Running setup.py (path:/tmp/pip-DclInS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:11 INFO - Running setup.py (path:/tmp/pip-8LWpy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:11 INFO - Running setup.py (path:/tmp/pip-Y8SeFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:11 INFO - Running setup.py (path:/tmp/pip-yyBo9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:11 INFO - Running setup.py (path:/tmp/pip-IGLwRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:58:11 INFO - Running setup.py install for manifestparser 17:58:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Running setup.py install for mozcrash 17:58:12 INFO - Running setup.py install for mozdebug 17:58:12 INFO - Running setup.py install for mozdevice 17:58:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Running setup.py install for mozfile 17:58:12 INFO - Running setup.py install for mozhttpd 17:58:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Running setup.py install for mozinfo 17:58:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Running setup.py install for mozInstall 17:58:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Running setup.py install for mozleak 17:58:12 INFO - Running setup.py install for mozlog 17:58:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:58:12 INFO - Running setup.py install for moznetwork 17:58:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:58:13 INFO - Running setup.py install for mozprocess 17:58:13 INFO - Running setup.py install for mozprofile 17:58:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:58:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:58:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:58:13 INFO - Running setup.py install for mozrunner 17:58:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:58:13 INFO - Running setup.py install for mozscreenshot 17:58:13 INFO - Running setup.py install for moztest 17:58:13 INFO - Running setup.py install for mozversion 17:58:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:58:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:58:13 INFO - Cleaning up... 17:58:13 INFO - Return code: 0 17:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58: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')]} 17:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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')]} 17:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58: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 17:58: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 17:58:13 INFO - Using env: {'DISPLAY': ':0', 17:58:13 INFO - 'HOME': '/home/cltbld', 17:58:13 INFO - 'LANG': 'en_US.UTF-8', 17:58:13 INFO - 'LANGUAGE': 'en_US:en', 17:58:13 INFO - 'LOGNAME': 'cltbld', 17:58:13 INFO - 'MAIL': '/var/mail/cltbld', 17:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:13 INFO - 'MOZ_NO_REMOTE': '1', 17:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:13 INFO - 'NO_EM_RESTART': '1', 17:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:13 INFO - 'PWD': '/builds/slave/test', 17:58:13 INFO - 'SHELL': '/bin/bash', 17:58:13 INFO - 'SHLVL': '1', 17:58:13 INFO - 'TERM': 'linux', 17:58:13 INFO - 'TMOUT': '86400', 17:58:13 INFO - 'USER': 'cltbld', 17:58:13 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:13 INFO - '_': '/tools/buildbot/bin/python'} 17:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:13 INFO - Running setup.py (path:/tmp/pip-Ezfymp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:14 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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:14 INFO - Running setup.py (path:/tmp/pip-uasoEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:14 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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:14 INFO - Running setup.py (path:/tmp/pip-yfjhRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:14 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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:14 INFO - Running setup.py (path:/tmp/pip-0ezVdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:14 INFO - Running setup.py (path:/tmp/pip-Fm7gd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:14 INFO - Running setup.py (path:/tmp/pip-qaKHyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:14 INFO - Running setup.py (path:/tmp/pip-ZKKU4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:14 INFO - Running setup.py (path:/tmp/pip-MlHjNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:14 INFO - Running setup.py (path:/tmp/pip-R7QfnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:14 INFO - Running setup.py (path:/tmp/pip-9NcJL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:14 INFO - Running setup.py (path:/tmp/pip-uDLsLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:14 INFO - Running setup.py (path:/tmp/pip-WVv8NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:14 INFO - Running setup.py (path:/tmp/pip-eHC_Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:14 INFO - Running setup.py (path:/tmp/pip-qPvWLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58: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)) 17:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:14 INFO - Running setup.py (path:/tmp/pip-tFQfRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:15 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)) 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:15 INFO - Running setup.py (path:/tmp/pip-2xlT2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:15 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)) 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:15 INFO - Running setup.py (path:/tmp/pip-lYCklV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:15 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)) 17:58:15 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)) 17:58:15 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)) 17:58:15 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)) 17:58:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:58:15 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 17:58:15 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 17:58:15 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 17:58:15 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 17:58:15 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 17:58:15 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 17:58:17 INFO - Downloading blessings-1.6.tar.gz 17:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:58:17 INFO - Installing collected packages: blessings 17:58:17 INFO - Running setup.py install for blessings 17:58:17 INFO - Successfully installed blessings 17:58:17 INFO - Cleaning up... 17:58:17 INFO - Return code: 0 17:58:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:17 INFO - Reading from file tmpfile_stdout 17:58:17 INFO - Current package versions: 17:58:17 INFO - argparse == 1.2.1 17:58:17 INFO - blessings == 1.6 17:58:17 INFO - blobuploader == 1.2.4 17:58:17 INFO - docopt == 0.6.1 17:58:17 INFO - functools32 == 3.2.3-2 17:58:17 INFO - jsonschema == 2.5.1 17:58:17 INFO - manifestparser == 1.1 17:58:17 INFO - mozInstall == 1.12 17:58:17 INFO - mozcrash == 1.0 17:58:17 INFO - mozdebug == 0.1 17:58:17 INFO - mozdevice == 0.49 17:58:17 INFO - mozfile == 1.2 17:58:17 INFO - mozhttpd == 0.7 17:58:17 INFO - mozinfo == 0.9 17:58:17 INFO - mozleak == 0.1 17:58:17 INFO - mozlog == 3.4 17:58:17 INFO - moznetwork == 0.27 17:58:17 INFO - mozprocess == 0.25 17:58:17 INFO - mozprofile == 0.28 17:58:17 INFO - mozrunner == 6.13 17:58:17 INFO - mozscreenshot == 0.1 17:58:17 INFO - mozsystemmonitor == 0.3 17:58:17 INFO - moztest == 0.8 17:58:17 INFO - mozversion == 1.4 17:58:17 INFO - psutil == 3.1.1 17:58:17 INFO - requests == 1.2.3 17:58:17 INFO - wsgiref == 0.1.2 17:58:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:17 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58:17 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 17:58:17 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 17:58:17 INFO - Using env: {'DISPLAY': ':0', 17:58:17 INFO - 'HOME': '/home/cltbld', 17:58:17 INFO - 'LANG': 'en_US.UTF-8', 17:58:17 INFO - 'LANGUAGE': 'en_US:en', 17:58:17 INFO - 'LOGNAME': 'cltbld', 17:58:17 INFO - 'MAIL': '/var/mail/cltbld', 17:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:17 INFO - 'MOZ_NO_REMOTE': '1', 17:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:17 INFO - 'NO_EM_RESTART': '1', 17:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:17 INFO - 'PWD': '/builds/slave/test', 17:58:17 INFO - 'SHELL': '/bin/bash', 17:58:17 INFO - 'SHLVL': '1', 17:58:17 INFO - 'TERM': 'linux', 17:58:17 INFO - 'TMOUT': '86400', 17:58:17 INFO - 'USER': 'cltbld', 17:58:17 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:17 INFO - '_': '/tools/buildbot/bin/python'} 17:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 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)) 17:58:17 INFO - Cleaning up... 17:58:17 INFO - Return code: 0 17:58:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:17 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', '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 17:58:17 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 17:58:17 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 17:58:17 INFO - Using env: {'DISPLAY': ':0', 17:58:17 INFO - 'HOME': '/home/cltbld', 17:58:17 INFO - 'LANG': 'en_US.UTF-8', 17:58:17 INFO - 'LANGUAGE': 'en_US:en', 17:58:17 INFO - 'LOGNAME': 'cltbld', 17:58:17 INFO - 'MAIL': '/var/mail/cltbld', 17:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:17 INFO - 'MOZ_NO_REMOTE': '1', 17:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:17 INFO - 'NO_EM_RESTART': '1', 17:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:17 INFO - 'PWD': '/builds/slave/test', 17:58:17 INFO - 'SHELL': '/bin/bash', 17:58:17 INFO - 'SHLVL': '1', 17:58:17 INFO - 'TERM': 'linux', 17:58:17 INFO - 'TMOUT': '86400', 17:58:17 INFO - 'USER': 'cltbld', 17:58:17 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:17 INFO - '_': '/tools/buildbot/bin/python'} 17:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:58:18 INFO - Cleaning up... 17:58:18 INFO - Return code: 0 17:58:18 INFO - Running post-action listener: _resource_record_post_action 17:58:18 INFO - Running post-action listener: _start_resource_monitoring 17:58:18 INFO - Starting resource monitoring. 17:58:18 INFO - [mozharness: 2017-03-28 00:58:18.186212Z] Finished create-virtualenv step (success) 17:58:18 INFO - [mozharness: 2017-03-28 00:58:18.186680Z] Running install step. 17:58:18 INFO - Running pre-action listener: _resource_record_pre_action 17:58:18 INFO - Running main action method: install 17:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:18 INFO - Reading from file tmpfile_stdout 17:58:18 INFO - Detecting whether we're running mozinstall >=1.0... 17:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:58:18 INFO - Reading from file tmpfile_stdout 17:58:18 INFO - Output received: 17:58:18 INFO - Usage: mozinstall [options] installer 17:58:18 INFO - Options: 17:58:18 INFO - -h, --help show this help message and exit 17:58:18 INFO - -d DEST, --destination=DEST 17:58:18 INFO - Directory to install application into. [default: 17:58:18 INFO - "/builds/slave/test"] 17:58:18 INFO - --app=APP Application being installed. [default: firefox] 17:58:18 INFO - mkdir: /builds/slave/test/build/application 17:58:18 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'] 17:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:58:34 INFO - Reading from file tmpfile_stdout 17:58:34 INFO - Output received: 17:58:34 INFO - /builds/slave/test/build/application/firefox/firefox 17:58:34 INFO - Running post-action listener: _resource_record_post_action 17:58:34 INFO - [mozharness: 2017-03-28 00:58:34.504374Z] Finished install step (success) 17:58:34 INFO - [mozharness: 2017-03-28 00:58:34.504518Z] Running run-tests step. 17:58:34 INFO - Running pre-action listener: _resource_record_pre_action 17:58:34 INFO - Running main action method: run_tests 17:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:58:34 INFO - Python 2.7.3 17:58:34 INFO - Return code: 0 17:58:34 INFO - grabbing minidump binary from tooltool 17:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:34 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 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:58:34 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 17:58:34 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 17:58:34 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 17:58:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:58:34 INFO - Return code: 0 17:58:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:58:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:58:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:58:34 INFO - ENV: RUST_BACKTRACE is now 1 17:58:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:58:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:58:34 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/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 17:58:34 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/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 17:58:34 INFO - Using env: {'DISPLAY': ':0', 17:58:34 INFO - 'HOME': '/home/cltbld', 17:58:34 INFO - 'LANG': 'en_US.UTF-8', 17:58:34 INFO - 'LANGUAGE': 'en_US:en', 17:58:34 INFO - 'LOGNAME': 'cltbld', 17:58:34 INFO - 'MAIL': '/var/mail/cltbld', 17:58:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:58:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:34 INFO - 'MOZ_NO_REMOTE': '1', 17:58:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:34 INFO - 'NO_EM_RESTART': '1', 17:58:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:34 INFO - 'PWD': '/builds/slave/test', 17:58:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:58:34 INFO - 'RUST_BACKTRACE': '1', 17:58:34 INFO - 'SHELL': '/bin/bash', 17:58:34 INFO - 'SHLVL': '1', 17:58:34 INFO - 'TERM': 'linux', 17:58:34 INFO - 'TMOUT': '86400', 17:58:34 INFO - 'USER': 'cltbld', 17:58:34 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032', 17:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:34 INFO - '_': '/tools/buildbot/bin/python'} 17:58:34 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/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 17:58:34 INFO - mozversion application_buildid: 20170328001342 17:58:34 INFO - mozversion application_changeset: 5182b2c4b963ed87d038c7d9a4021463917076cd 17:58:34 INFO - mozversion application_display_name: Nightly 17:58:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:58:34 INFO - mozversion application_name: Firefox 17:58:34 INFO - mozversion application_remotingname: firefox 17:58:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:58:34 INFO - mozversion application_vendor: Mozilla 17:58:34 INFO - mozversion application_version: 55.0a1 17:58:34 INFO - mozversion platform_buildid: 20170328001342 17:58:34 INFO - mozversion platform_changeset: 5182b2c4b963ed87d038c7d9a4021463917076cd 17:58:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:58:34 INFO - mozversion platform_version: 55.0a1 17:58:34 INFO - using testdate: 1490662714 17:58:34 INFO - actual date: 1490662714 17:58:34 INFO - starting webserver on 'localhost:59093' 17:58:34 INFO - SUITE-START | Running 2 tests 17:58:34 INFO - TEST-START | dromaeo_css 17:58:34 INFO - operating with platform_type : linux_ 17:58:34 INFO - Initialising browser for dromaeo_css test... 17:58:34 INFO - TEST-INFO | started process 5024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXmqZzd/profile http://localhost:59093/getInfo.html) 17:58:38 INFO - PID 5024 | __metrics Screen width/height:1600/1200 17:58:38 INFO - PID 5024 | colorDepth:24 17:58:38 INFO - PID 5024 | Browser inner width/height: 1024/697 17:58:38 INFO - PID 5024 | __metrics 17:58:39 ERROR - PID 5024 | 1490662719929 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:58:40 INFO - PID 5024 | 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" 17:58:40 INFO - PID 5024 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:41 INFO - TEST-INFO | 5024: exit 0 17:58:41 INFO - Browser initialized. 17:58:41 INFO - Running cycle 1/1 for dromaeo_css test... 17:58:41 INFO - TEST-INFO | started process 5125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXmqZzd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:53 INFO - PID 5125 | RSS: Main: 168230912 17:58:53 INFO - PID 5125 | 18:02:00 INFO - PID 5125 | Cycle 1(1): loaded http://localhost:59093/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59093/tests/dromaeo/cssquery-ext.html) 18:02:02 INFO - PID 5125 | RSS: Main: 355065856 18:02:02 INFO - PID 5125 | 18:03:42 INFO - PID 5125 | ************************* 18:03:42 INFO - PID 5125 | A coding exception was thrown and uncaught in a Task. 18:03:42 INFO - PID 5125 | 18:03:42 ERROR - PID 5125 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:42 INFO - PID 5125 | Full stack: 18:03:42 INFO - PID 5125 | ************************* 18:03:42 INFO - PID 5125 | ************************* 18:03:42 INFO - PID 5125 | A coding exception was thrown and uncaught in a Task. 18:03:42 INFO - PID 5125 | 18:03:42 ERROR - PID 5125 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:42 INFO - PID 5125 | Full stack: 18:03:42 INFO - PID 5125 | ************************* 18:03:42 INFO - PID 5125 | ************************* 18:03:42 INFO - PID 5125 | A coding exception was thrown and uncaught in a Task. 18:03:42 INFO - PID 5125 | 18:03:42 ERROR - PID 5125 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:42 INFO - PID 5125 | Full stack: 18:03:42 INFO - PID 5125 | ************************* 18:03:42 INFO - PID 5125 | ************************* 18:03:42 INFO - PID 5125 | A coding exception was thrown and uncaught in a Task. 18:03:42 INFO - PID 5125 | 18:03:42 ERROR - PID 5125 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:42 INFO - PID 5125 | Full stack: 18:03:42 INFO - PID 5125 | ************************* 18:05:05 INFO - PID 5125 | Cycle 1(1): loaded http://localhost:59093/tests/dromaeo/cssquery-ext.html (next: http://localhost:59093/tests/dromaeo/cssquery-jquery.html) 18:05:05 INFO - PID 5125 | RSS: Main: 264134656 18:05:05 INFO - PID 5125 | 18:08:08 INFO - PID 5125 | Cycle 1(1): loaded http://localhost:59093/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59093/tests/dromaeo/cssquery-mootools.html) 18:08:08 INFO - PID 5125 | RSS: Main: 200904704 18:08:08 INFO - PID 5125 | 18:11:11 INFO - PID 5125 | Cycle 1(1): loaded http://localhost:59093/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59093/tests/dromaeo/cssquery-prototype.html) 18:11:11 INFO - PID 5125 | RSS: Main: 205553664 18:11:11 INFO - PID 5125 | 18:14:15 INFO - PID 5125 | Cycle 1(1): loaded http://localhost:59093/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59093/tests/dromaeo/cssquery-yui.html) 18:14:15 INFO - PID 5125 | RSS: Main: 214941696 18:14:15 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | Cycle 1(1): loaded http://localhost:59093/tests/dromaeo/cssquery-yui.html (next: http://localhost:59093/tests/dromaeo/cssquery-dojo.html) 18:17:19 INFO - PID 5125 | RSS: Main: 285732864 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | __start_tp_report 18:17:19 INFO - PID 5125 | _x_x_mozilla_page_load 18:17:19 INFO - PID 5125 | _x_x_mozilla_page_load_details 18:17:19 INFO - PID 5125 | |i|pagename|runs| 18:17:19 INFO - PID 5125 | |0;dojo.html;2734.8495832729204;2778.5554311310193;2805.7895657825657;2809.7471227589513;2829.54727243641;5116.565091967178;5198.974005129979;5287.65630234035;5312.707801070945;5314.89370212596;5145.511176438242;5151.845444636667;5152.536271735543;5172.534471897528;5177.042247184274;4700.012997270569;4712.246040633499;4824.951750482503;4871.732054736988;4879.853604391857;4803.807847686106;4808.2547205183255;4825.734584597846;4830.637702172334;4837.661363704525;368.91973151744656;4815.181419158716;4866.221404575269;4866.780994855222;4885.609151267908;4269.658427325838;4764.309175169581;4790.449098353699;4802.279658051285;4844.467108618049;4752.049590081963;4766.904661906742;4777.116233496814;4778.331033655291;4802.543758342987;5037.974810125926;5082.618803589746;5161.612879034087;5183.481651834786;5195.246689230078;5608.915866262009;5641.71791410432;5690.089585666315;5700.287464066992;5707.600467967244;5701.315842098933;5744.6840423776675;5748.310202775652;5752.626079304873;5755.482006619382;5381.865453363697;5388.515033646991;5413.242146099549;5415.53967912724;5418.45815418455;5732.512736417368;5809.128630705428;5810.6513609183585;5836.941630583725;5874.706264686749;5591.329040515164;5606.1030235163;5610.242617246701;5612.382637909826;5642.548596112301;5514.310711161105;5576.386597474275;5582.63712858671;5631.6902570359025;5678.261825962599;5527.088030475007;5586.581006424453;5626.43735626434;5626.662400255997;5630.690312032795;5472.890542189134;5518;5522.944770552243;5567.638103523258;5611.8597035073635;4609.976950115295;4644.8374306899095;4661.510541393172;4680.789364478606;4690.061987602425;3980.5621381647998;3984.4222587724616;3995.10110225197;4014.558398576154;4038.8788336349958;4603.723776573416;4651.395318608627;4702.435707715096;4708.152532544106;4749.26386410107;5576.442355764391;5668.943310566841;5735.856603584861;5748.252727145528;5749.9425005750245;4746.667733258708;4769.165396055676;4774.5464180903455;4776.665633405698;4820.204666230033;5034.144195486776;5036.5718913892;5062.417821950523;5064.290999260106;5110.8466745997675;5202.583793296603;5238.371395432572;5242.475752424727;5245.344331958505;5284.075286824714;5551;5600.187972744011;5608.327000759935;5651.773929042793;5663.3770285267765;5205.869853253699;5243.737813109253;5253.395859476209;5253.422123566481;5312;5476.424975377528;5523.309586301712;5538.418466061005;5538.944610553843;5540.7783688652;5608.85977850557;5636.887262254814;5638.041532939492;5638.830835074954;5641.041023026178;5434.402215756343;5459.508644222039;5463.344398672185;5500.064988951808;5553.361363443256;5441.075017247156;5470.617056805985;5494.862628434321;5519.31008623922;5545.417731138173;5412.377576578587;5427.294451721251;5437.510624043855;5439.728013599383;5482.205080263419;5399.082156033405;5463.153211252262;5526.834194974157;5528.253685752372;5533.667979921218;5347.839564813062;5350.705711185767;5356.973215133899;5388.353397592314;5399.676019438846 18:17:19 INFO - PID 5125 | |1;ext.html;703.5919166883208;726.6984201556353;1062.3413483640145;1082.631905152248;1083.7669900971289;30697.846510767442;31516.842415787916;31527.211819704462;31582.368352632933;31593.84203078987;33646.32707345852;34027.82986085066;34109.65890341096;34120.31759364811;34129.31741365171;5582.078956972095;7267.454940879429;7398.926010739904;7401.296876796696;7410.851782964338;5514.724263786815;7098.254683258261;7323.340899319061;7327.340539351458;7330.083739532559;7408.370288525455;7454.664540095681;7458.664360103781;7463.626818659072;7467.215942326059;7357.117145942468;7417.184109747924;7417.851642967111;7420.146683131455;7427.220141885078;7268.273172682742;7311.744088956914;7439.330460258603;7441.032665753418;7454.40364770817;32111.839440802647;32323.353532929446;32354;32356.83821580877;32376;2578.1234380310784;2606.960895586568;2612.7256638052922;2663.840169589831;2683.154806236049;20988.685169722467;21138.788612113836;21243.25648602307;22226.666600001012;22245.332640020664;2957.5859379686863;2975.0628552006265;2976.0922918509846;3005.443992861328;3069.3247485553143;138163;138621.14825981043;139252;139256;140145.299273504;32060.19849503781;32666.510002349984;40218.59781402207;40374.59625403767;40432.79783601063;39505.40741888874;40049.39925901114;40087;40298.79850600728;40319.39520907189;11694.122940779305;11702.356370399539;11802.055835533136;11804.76390472203;12013.219140755822;9245.075492450836;9252.722418327461;9283.303752218611;9331.393459425115;9470;13291.734165316639;13295.800562991562;13306.73386532264;13344.399502022432;13543.796843047363;5401.4868587484125;5445.782168713286;5544.445555444504;5559.416261292587;5587.357453892773;891.3003292415423;901.8647202919615;917.8760867282831;918.7151982885193;922.9907700923039;19829;20650.27724029682;21009.78990210109;21096.261630842848;21495.140194392363;983.3116818227127;986.8371718666483;987.3236832769576;987.53585814667;987.8123156600367;10600.787984240425;10832.24174307791;11064.446777661085;11081.889181108085;11084.390358530198;248294;250300;250324;250431;250797;42140.578594214276;42388.78805605952;42458.36312455316;42487.36268955968;42512.78743606324;1215.4469716279073;1248.9687757805946;1262.9810552841714;1264.5321231144535;1267.8478582569967;19296.61406771885;19907;20039.398818035483;20231.291904783262;20584.897075514527;29926.70073299239;30137.09588712342;30139.3972120552;30150;30166;223577;223721;225562.16567515003;225737;225754;28172;28563.714362856106;28595;28657.570136447554;28667;34405;34539.4819077709;34751.826240868635;35318.117047074025;35360.469592956644;27820.30449238785;28027.159185224475;28260.43479130447;29308;29940.550891736206;29868.85065574745;30157.547636785905;30495.237619059702;30654.846725766227;31190.22024449316;34278.65721342755;34559.82720086384;35115;35130.82434587811;35139.82430087833;29936.101916942527;29939.401211976074;30431.54352684756;30876.845615772676;31131.462392897745;23503.764962350157;23766.168184113474;23892;24048.51902961966;24261.180411468857 18:17:19 INFO - PID 5125 | |2;jquery.html;388.74537178148324;418.52407000058395;432.44214962698123;434.5979968529111;444.69538366219143;13555.864441355583;17485.912570437147;17622;18472.722909156375;18531.444056678287;18296.268149274045;18405.355812546564;18564.907175464105;18675.43973680792;18918.527036824053;5460.836174914759;5720.79977200798;5720.8855822883515;5729.026065568843;5731.168980497825;3324.4182268102986;3496.5804103507617;5397.595180361469;5570.053090974524;5622.128570071645;5622.072358060936;5625.128105143709;5627.662340259598;5628.465295796893;5628.493435590796;5381.784728610871;5607.186957891124;5618.550515958734;5622.943770562283;5636.436356364372;5081.364829396325;5082.288479612857;5082.669626474304;5085;5089.287499750038;20647.380578582666;21439.785602143937;21483;21519.246826361003;21541.892290538603;1500.354847415611;1501.3469140923623;1504.488473918862;1512.6294057955872;1528.678977414733;13393.66515837102;13440.395182216824;13555.661108472268;13588.456461741518;14174.645633859132;1529.9388024479008;1532.0807515490728;1538.96152596186;1550.9922450387676;1569.5291412576296;76266.61866690687;76605.61697191479;76763;77473;79163.6041819793;9095.49974751395;10348.793024139475;10753.408562528979;10778.94610526958;10976;13149.408276627575;13186.868131318755;13905.930470347583;14374.425022998963;14375.712485750435;7269.091363579552;7324.707011719578;7385.335319821134;7415.221401752846;7486.363659089038;6535.8692826143215;6633.369829866155;6765.932340676629;6786.898196527056;6790.185177778698;6772.458203343721;6785.762498312634;6795.694193761293;6941.939162189937;7017.157941047107;1966.3609326968506;2000.779914209436;2025.9363833987275;2027.178992508007;2039.439154232598;869.1091631078195;904.1049361132563;904.8054668246359;906.1074841281333;923.5428462910768;16252;16268.837311626969;16858.157092145342;16871.662566748597;17067.743983840253;902.0798785239151;907.732218995398;913.1279627955287;918.1094338491653;927.2923064651235;8769.868451973225;8845.911540884508;9327.486988215713;9547.2839537035;9575.616975321049;453200;454325;456264.4373556222;459404;462451;80631.59684201659;83027.58486207531;84041.57979210065;85140.57429712811;85536;1046.3721766939775;1075.1184029096223;1100.7688385438987;1102.5479553383075;1105.0551778229499;14035.929820350833;14211.715765684836;14216.431342746175;14380.705736483767;14908.180050096915;40131;41871.1625767489;43393.56606433895;44833.775831120634;45457.77271113623;54107.18839217494;55513.444865550824;56113;56343.43656563382;58554.12168817386;7622.352100071556;7637.694492220249;7907.2488113629115;8068.354531637572;8125.212453260273;11068.612598559333;11396.544138234378;11482.253653512495;11844.70388240301;11853.466594003117;9121.179093881583;9250.259979201513;9288.674896378594;9421.764455888657;9539.998300178382;9376.531173441164;9392.154706076486;9406.247500200105;9458.148766611039;9493.525323733924;9641.951790241004;9644.469554174308;9866.309358344846;9997.800043999225;10059.74850628711;7489.962550187214;7529.171791103084;7579.924200757921;7627.466077374531;7726.227377262454;9619.903800961902;9662.806743864943;9745.463999480096;9906.950465247915;10131.544080516247 18:17:19 INFO - PID 5125 | |3;mootools.html;1288.1562576512385;1331.6737399337164;1332.7334533093383;1351.6755978565145;1356.5184359552359;9367.578458969345;9698.854517182248;9699.951500242507;9746.805063898717;9751.951240243807;9539.666111686092;9609;9900.50497475127;9901.356411833243;9903.15823155031;2237.854539454934;2263.207877242968;2266.0822366941416;2266.9659955100606;2269.183094086136;2081.438011736838;2200.2189222825905;2217.8558393704357;2222.4999375140546;2227.498812767131;1907.818757218062;1974.0820518458913;2172.7935846094597;2247.539254452833;2251.5722012817514;2257.6500642400456;2276.521930394619;2276.7267927848766;2277.6583512473094;2279.7150356205475;2170.4139882231866;2193.583219188365;2214.4574579228033;2220.1563405905813;2220.811231045363;9550.856737148948;9621.615135394575;9629.085236902552;9630.47032413217;9892.703218903445;5461.42655021225;5641.774329026834;5646.915296270559;5649.661020338752;5655.1799989001365;3061.7397521210723;3243.918902027445;3325.800451972865;3339.5658564386476;3346.9330613387597;923.8290916180528;970.2480577552383;989.7624570103123;1000.1099021870541;1002.8746406699163;14116.717665646733;14268.643283917881;14274.92862535691;14296.285185740671;14298;4811.27830825372;4903.313536104948;5000.974995125001;5030.773615187325;5074.974625126851;10768.78462430747;10899.346039237513;10924.18068644839;10925.344479331106;10927.180461465263;5503.559715222773;5508.779648814003;5516.310461192351;5517.420670829585;5519.586031047687;4970.751462426864;5112.667676601009;5174.508421699932;5207.166853303529;5217.243499692523;3738.775673459601;3903.2974064668633;3933;3946.151577410813;4008.819603117867;1125.6530134669306;1133.3030186435283;1134.7276653603076;1147.0995268714018;1152.4986630815622;560.095798327344;698.4970821008866;703.4056222491986;705.5590256089944;722.819295176206;5288;5338.3593968724;5507.476789704971;5532.3914369419335;5600.663960162403;816.1063635319316;832.1844592299581;837.2632083766368;837.8952630921135;851.5061264466594;3444.9655503445147;3484.738644601665;3609.0796846803896;3616.8010759408485;3762.6613604775703;11954.521819127138;12570.371481425893;12968.481260749653;12982.610521684364;12990.805137922938;12766.489340426278;12979.935100324437;12983.805242921364;12989.480420783251;13001.804972925414;9185.63257469707;9385.263726210536;9403.200727938201;9415.105564971316;9430.811383772287;5354.250404943233;5370.060239458001;5421.864453388539;5621.381648018796;5892.381299963614;11171.329720216812;11353.943230283796;11460.255083419552;11506.252093613888;11590.362530060927;11639.127065469955;11663.941680291544;11695.707607309885;11719.88280117188;11826.763464730486;8009.279164875189;8118;8197.549134797644;8207.056188538394;8210.794730131794;8767.430117042626;8912.197902188835;8940.821183576161;9001.279897608307;9020.59407326685;7502.549847009197;7536.585487798224;7567.243275672609;7686.231376862269;7807.375409967075;7313.195548489555;7434.73978410753;7439.330460258603;7459.291367320096;7488.5506869588;6786.0838786765125;6982.895256571257;7129.928700713134;7172.677229524788;7179.066721326194;4704.176769065331;4724.976375118103;4747.8575642730775;4767.261074533453;4873.122837889072;5067.214581739836;5142.151544995184;5208.270842082187;5213.947860521346;5233.110371236823 18:17:19 INFO - PID 5125 | |4;prototype.html;393.0939185178165;394.39263534157396;395.3318891074085;397.57459518315403;405.57617289932017;5226.189940559215;5336.839894803153;5346.304980352549;5383.703896285702;5391.838244852661;5097.286379906806;5218.895622087556;5220.425753167148;5282.867928301795;5285.630005899579;4232.841250962017;4243.787810609472;4251.723637963538;4265.722728022684;4274.764887931163;4239.682023848209;4245.129748401586;4254.361845723135;4256.255155347817;4269.807858646368;4132.814023368941;4227.112306415641;4241.639460645849;4246.872593822175;4253.787310634471;4191.8532851350365;4215.199112168678;4218.282891908383;4220.810063547117;4227.830886764541;3805.1818858945185;3812.2566099610585;3816.7519111257957;3819.1788765415567;3823.7323387362894;5105;5106.64253502255;5107.387113546361;5108.208227724708;5130.9230361544605;4502.144592527442;4688.460827004904;4731.597814185799;4735.763211839429;4758.262469317261;5638.35158956717;5641.18202860587;5648.209250704905;5650.333151720252;5658;3986.740861843971;3990.68074554035;4006.258842114189;4008;4016.3172260715455;5615.097507232475;5696.857578560569;5767.625104368287;5820.5634577406445;5968.731407086691;4045.6561192298986;4059.167870586523;4067.6407683543475;4079.224947260011;4084.244414783275;4128.8348466061025;4133.821860769726;4136.152088821785;4143.606357396043;4145.481814773153;4467.776611169428;4486.147631949984;4582.518835522222;4744.976275118672;4762.9523704762505;5624.915626265528;5632.690202038927;5636.859078522988;5637.8590535236945;5674;1411.5906387147613;1425.6222101143205;1436.5187662133303;1437.1018113678952;1438.3455527734855;956.6460409648474;957.3729207369184;964;974.7124598243536;981.651513712636;4859.343988561499;4893.09477746618;4899.191633380524;4899.407692499952;4899.755012249373;5813.447722466359;5824.88350232993;5847.26909136358;5849.561282903799;5872.941270587325;4637.350770892078;4847.660663753574;4850.80596776125;4867.7322747249245;4921.803127874845;3068.156257029335;3085.441851864794;3092.716522643123;3107.409592177479;3113.754498200738;5430.972845135749;5459.918101228484;5481.355593322067;5482.259894914216;5483;5714.685692286964;5943.435373639584;6021.157038014681;6037.275526936708;6045.486133678686;5487.012337779158;5499.587530935196;5510.173473978935;5511.338639363302;5532.225488431623;5743.540516758733;5836.795712150054;5880.117982302518;5880.7356418368545;5893.764249429974;5771.1920331154515;5786.971065144648;5790.536757059341;5791.710414479175;5803.564732644984;5169.327987361619;5260.684358938476;5349.866253343697;5464.590155738256;5465.207544905887;4051.8379264829077;4060.2488539620263;4085.22380747657;4089.5705950875918;4091.693123015726;5836.241288632451;5840.393891679822;5850.94149058504;5879.941200587939;5883.323417807007;5478.205660179172;5654.180143879197;5657.2079908811975;5665.631733937281;5698.088305871041;5652.943470565242;5655.406182350794;5671.149327600893;5676.120201368794;5729.512991395778;5388.676679399248;5613.775448981995;5619.634723742944;5621.606487545832;5635;5732.283464566929;5734.2258795062135;5736.082226843685;5744.281964754406;5752.568557358131;5535.612507124623;5561.443855614406;5566.165075238585;5566.220729097849;5574.888502230014 18:17:19 INFO - PID 5125 | |5;yui.html;589.5195415736177;598.1177762799869;669.4945316286203;683.4525248122982;697.6755808549024;11014.559417623295;11586.82619760702;12055.156139070268;12065.758684826298;12335.506579736822;11837.408129593507;12028.51885924562;12088.939555302233;12100.092493063012;12245.204061736003;811.1077814404138;812.7033632724043;828.0642873552877;833.8499070167368;835.7952301686065;840.315143158324;849.46908182386;850.3664769746548;851.2423942691009;851.276415047208;881.6517475597135;883.2007033634571;883.9469631822111;884.8938127424718;885.1944730295432;870.0429527519741;875.7722992022057;876.925461335784;877.368294827723;878.547548012774;646.2761706888268;646.9902951455732;648.5524987758431;648.6951132967498;649.3571364349308;13006.804897926539;13153.671158221025;13170.736585268241;13191.934040329834;13821.101628394123;12815.487380504768;13559.661008474768;13644.454221831214;13823.78526158817;13826;9964.451955142464;10227.948860255725;10406.84389734147;10581.418022008786;10610.098141657969;2719.1298784389005;2732.4671689020647;2736.5484695025298;2745.341118131634;2751.490974169785;65358;66583.66708166429;67334.66332668305;69279.30720692778;69301.30698693;10568.313059651098;10585.629502967358;10608.461534640352;10644.148468122532;10809.567617295377;21735.56528869414;21776.673349899764;21779.564408712053;21823.563528729337;21852.344429667137;5954.345022047572;5988.850278742979;6148.1392605035335;6229.408206220402;6320.5575609706875;3094.8916787912767;3154.7160755531654;3174.920626984344;3186.2512309607223;3314.254292784104;3513.508108864761;3572.374834403969;3585.515955345995;3586.9597816632886;3950.822213000422;750.312215461003;755.7543798265476;763.6143747407524;767.0795045944889;777.4596655324608;449.91901457737265;479.7864950097173;488.7067759344436;538.1953978801638;571.8827640333805;8081.717139900193;8356.746488026845;8623.698170564126;8641.956790216009;8756.693515726918;541.4477233222092;552.2737600055914;554.9805756798493;562.5274769193896;575.203343369428;3785.5268091488565;4006.719529632956;4012.9799351003057;4124.175164967019;4156.937645935313;49767.253491196934;62652.06021909675;63469.36530634727;63975.68012159909;66283;35671.64328356735;44840;46098;50998.49001509937;52928.73535632297;44337.113257734665;44886.32670509945;44981.55018449773;46406.767966159954;47282.76358618185;8969.37214394986;9486.667966621411;9504.267729210214;9625.855612165684;9667.129958303787;24677.876610616833;24831.87584062068;25010.74989250084;25500.48999019972;26427.867860660575;24696.876515617307;24864.875675621504;28994.85502572558;29039.419211615226;30165.396692066475;11698.737864560047;11926.284422934652;11936.880631193924;11953.163278570417;12216.877831221575;12548.749025019632;12575.119741617998;12673.17624354414;12716.173448725804;13305.268210248529;11076.723081923017;11260.83108753353;11742.882571174521;11889.583864564698;11895.762084758084;11855.58505452305;12181.39093045362;12300.446479908605;12324.383780811102;12682.936585317015;11149.498272577592;11617.76764464689;11787.882121178678;12098.879011209776;12223.266604003788;8460.534670593177;8677.262432693291;8934;8994.415363001384;9170.908290917005;9132.543372831198;9815.823039242288;9853.359531630422;9953.402795832273;9971.152452041368 18:17:19 INFO - PID 5125 | __end_tp_report 18:17:19 INFO - PID 5125 | __start_cc_report 18:17:19 INFO - PID 5125 | _x_x_mozilla_cycle_collect,2217 18:17:19 INFO - PID 5125 | __end_cc_report 18:17:19 INFO - PID 5125 | __startTimestamp1490663839468__endTimestamp 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | ------- Summary: start ------- 18:17:19 INFO - PID 5125 | Number of tests: 6 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | [#0] dojo.html Cycles:165 Average:5144.66 Median:5356.97 stddev:700.19 (13.1%) stddev-sans-first:676.34 18:17:19 INFO - PID 5125 | Values: 2734.8 2778.6 2805.8 2809.7 2829.5 5116.6 5199.0 5287.7 5312.7 5314.9 5145.5 5151.8 5152.5 5172.5 5177.0 4700.0 4712.2 4825.0 4871.7 4879.9 4803.8 4808.3 4825.7 4830.6 4837.7 368.9 4815.2 4866.2 4866.8 4885.6 4269.7 4764.3 4790.4 4802.3 4844.5 4752.0 4766.9 4777.1 4778.3 4802.5 5038.0 5082.6 5161.6 5183.5 5195.2 5608.9 5641.7 5690.1 5700.3 5707.6 5701.3 5744.7 5748.3 5752.6 5755.5 5381.9 5388.5 5413.2 5415.5 5418.5 5732.5 5809.1 5810.7 5836.9 5874.7 5591.3 5606.1 5610.2 5612.4 5642.5 5514.3 5576.4 5582.6 5631.7 5678.3 5527.1 5586.6 5626.4 5626.7 5630.7 5472.9 5518.0 5522.9 5567.6 5611.9 4610.0 4644.8 4661.5 4680.8 4690.1 3980.6 3984.4 3995.1 4014.6 4038.9 4603.7 4651.4 4702.4 4708.2 4749.3 5576.4 5668.9 5735.9 5748.3 5749.9 4746.7 4769.2 4774.5 4776.7 4820.2 5034.1 5036.6 5062.4 5064.3 5110.8 5202.6 5238.4 5242.5 5245.3 5284.1 5551.0 5600.2 5608.3 5651.8 5663.4 5205.9 5243.7 5253.4 5253.4 5312.0 5476.4 5523.3 5538.4 5538.9 5540.8 5608.9 5636.9 5638.0 5638.8 5641.0 5434.4 5459.5 5463.3 5500.1 5553.4 5441.1 5470.6 5494.9 5519.3 5545.4 5412.4 5427.3 5437.5 5439.7 5482.2 5399.1 5463.2 5526.8 5528.3 5533.7 5347.8 5350.7 5357.0 5388.4 5399.7 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | [#1] ext.html Cycles:180 Average:34231.40 Median:30787.35 stddev:54865.49 (178.2%) stddev-sans-first:54961.65 18:17:19 INFO - PID 5125 | Values: 703.6 726.7 1062.3 1082.6 1083.8 30697.8 31516.8 31527.2 31582.4 31593.8 33646.3 34027.8 34109.7 34120.3 34129.3 5582.1 7267.5 7398.9 7401.3 7410.9 5514.7 7098.3 7323.3 7327.3 7330.1 7408.4 7454.7 7458.7 7463.6 7467.2 7357.1 7417.2 7417.9 7420.1 7427.2 7268.3 7311.7 7439.3 7441.0 7454.4 32111.8 32323.4 32354.0 32356.8 32376.0 2578.1 2607.0 2612.7 2663.8 2683.2 20988.7 21138.8 21243.3 22226.7 22245.3 2957.6 2975.1 2976.1 3005.4 3069.3 138163.0 138621.1 139252.0 139256.0 140145.3 32060.2 32666.5 40218.6 40374.6 40432.8 39505.4 40049.4 40087.0 40298.8 40319.4 11694.1 11702.4 11802.1 11804.8 12013.2 9245.1 9252.7 9283.3 9331.4 9470.0 13291.7 13295.8 13306.7 13344.4 13543.8 5401.5 5445.8 5544.4 5559.4 5587.4 891.3 901.9 917.9 918.7 923.0 19829.0 20650.3 21009.8 21096.3 21495.1 983.3 986.8 987.3 987.5 987.8 10600.8 10832.2 11064.4 11081.9 11084.4 248294.0 250300.0 250324.0 250431.0 250797.0 42140.6 42388.8 42458.4 42487.4 42512.8 1215.4 1249.0 1263.0 1264.5 1267.8 19296.6 19907.0 20039.4 20231.3 20584.9 29926.7 30137.1 30139.4 30150.0 30166.0 223577.0 223721.0 225562.2 225737.0 225754.0 28172.0 28563.7 28595.0 28657.6 28667.0 34405.0 34539.5 34751.8 35318.1 35360.5 27820.3 28027.2 28260.4 29308.0 29940.6 29868.9 30157.5 30495.2 30654.8 31190.2 34278.7 34559.8 35115.0 35130.8 35139.8 29936.1 29939.4 30431.5 30876.8 31131.5 23503.8 23766.2 23892.0 24048.5 24261.2 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | [#2] jquery.html Cycles:180 Average:27049.13 Median:29784.01 stddev:75432.43 (253.3%) stddev-sans-first:75617.48 18:17:19 INFO - PID 5125 | Values: 388.7 418.5 432.4 434.6 444.7 13555.9 17485.9 17622.0 18472.7 18531.4 18296.3 18405.4 18564.9 18675.4 18918.5 5460.8 5720.8 5720.9 5729.0 5731.2 3324.4 3496.6 5397.6 5570.1 5622.1 5622.1 5625.1 5627.7 5628.5 5628.5 5381.8 5607.2 5618.6 5622.9 5636.4 5081.4 5082.3 5082.7 5085.0 5089.3 20647.4 21439.8 21483.0 21519.2 21541.9 1500.4 1501.3 1504.5 1512.6 1528.7 13393.7 13440.4 13555.7 13588.5 14174.6 1529.9 1532.1 1539.0 1551.0 1569.5 76266.6 76605.6 76763.0 77473.0 79163.6 9095.5 10348.8 10753.4 10778.9 10976.0 13149.4 13186.9 13905.9 14374.4 14375.7 7269.1 7324.7 7385.3 7415.2 7486.4 6535.9 6633.4 6765.9 6786.9 6790.2 6772.5 6785.8 6795.7 6941.9 7017.2 1966.4 2000.8 2025.9 2027.2 2039.4 869.1 904.1 904.8 906.1 923.5 16252.0 16268.8 16858.2 16871.7 17067.7 902.1 907.7 913.1 918.1 927.3 8769.9 8845.9 9327.5 9547.3 9575.6 453200.0 454325.0 456264.4 459404.0 462451.0 80631.6 83027.6 84041.6 85140.6 85536.0 1046.4 1075.1 1100.8 1102.5 1105.1 14035.9 14211.7 14216.4 14380.7 14908.2 40131.0 41871.2 43393.6 44833.8 45457.8 54107.2 55513.4 56113.0 56343.4 58554.1 7622.4 7637.7 7907.2 8068.4 8125.2 11068.6 11396.5 11482.3 11844.7 11853.5 9121.2 9250.3 9288.7 9421.8 9540.0 9376.5 9392.2 9406.2 9458.1 9493.5 9642.0 9644.5 9866.3 9997.8 10059.7 7490.0 7529.2 7579.9 7627.5 7726.2 9619.9 9662.8 9745.5 9907.0 10131.5 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | [#3] mootools.html Cycles:180 Average:6123.05 Median:5015.87 stddev:3877.85 (77.3%) stddev-sans-first:3871.71 18:17:19 INFO - PID 5125 | Values: 1288.2 1331.7 1332.7 1351.7 1356.5 9367.6 9698.9 9700.0 9746.8 9752.0 9539.7 9609.0 9900.5 9901.4 9903.2 2237.9 2263.2 2266.1 2267.0 2269.2 2081.4 2200.2 2217.9 2222.5 2227.5 1907.8 1974.1 2172.8 2247.5 2251.6 2257.7 2276.5 2276.7 2277.7 2279.7 2170.4 2193.6 2214.5 2220.2 2220.8 9550.9 9621.6 9629.1 9630.5 9892.7 5461.4 5641.8 5646.9 5649.7 5655.2 3061.7 3243.9 3325.8 3339.6 3346.9 923.8 970.2 989.8 1000.1 1002.9 14116.7 14268.6 14274.9 14296.3 14298.0 4811.3 4903.3 5001.0 5030.8 5075.0 10768.8 10899.3 10924.2 10925.3 10927.2 5503.6 5508.8 5516.3 5517.4 5519.6 4970.8 5112.7 5174.5 5207.2 5217.2 3738.8 3903.3 3933.0 3946.2 4008.8 1125.7 1133.3 1134.7 1147.1 1152.5 560.1 698.5 703.4 705.6 722.8 5288.0 5338.4 5507.5 5532.4 5600.7 816.1 832.2 837.3 837.9 851.5 3445.0 3484.7 3609.1 3616.8 3762.7 11954.5 12570.4 12968.5 12982.6 12990.8 12766.5 12979.9 12983.8 12989.5 13001.8 9185.6 9385.3 9403.2 9415.1 9430.8 5354.3 5370.1 5421.9 5621.4 5892.4 11171.3 11353.9 11460.3 11506.3 11590.4 11639.1 11663.9 11695.7 11719.9 11826.8 8009.3 8118.0 8197.5 8207.1 8210.8 8767.4 8912.2 8940.8 9001.3 9020.6 7502.5 7536.6 7567.2 7686.2 7807.4 7313.2 7434.7 7439.3 7459.3 7488.6 6786.1 6982.9 7129.9 7172.7 7179.1 4704.2 4725.0 4747.9 4767.3 4873.1 5067.2 5142.2 5208.3 5213.9 5233.1 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | [#4] prototype.html Cycles:180 Average:4679.33 Median:5271.78 stddev:1354.51 (25.7%) stddev-sans-first:1319.55 18:17:19 INFO - PID 5125 | Values: 393.1 394.4 395.3 397.6 405.6 5226.2 5336.8 5346.3 5383.7 5391.8 5097.3 5218.9 5220.4 5282.9 5285.6 4232.8 4243.8 4251.7 4265.7 4274.8 4239.7 4245.1 4254.4 4256.3 4269.8 4132.8 4227.1 4241.6 4246.9 4253.8 4191.9 4215.2 4218.3 4220.8 4227.8 3805.2 3812.3 3816.8 3819.2 3823.7 5105.0 5106.6 5107.4 5108.2 5130.9 4502.1 4688.5 4731.6 4735.8 4758.3 5638.4 5641.2 5648.2 5650.3 5658.0 3986.7 3990.7 4006.3 4008.0 4016.3 5615.1 5696.9 5767.6 5820.6 5968.7 4045.7 4059.2 4067.6 4079.2 4084.2 4128.8 4133.8 4136.2 4143.6 4145.5 4467.8 4486.1 4582.5 4745.0 4763.0 5624.9 5632.7 5636.9 5637.9 5674.0 1411.6 1425.6 1436.5 1437.1 1438.3 956.6 957.4 964.0 974.7 981.7 4859.3 4893.1 4899.2 4899.4 4899.8 5813.4 5824.9 5847.3 5849.6 5872.9 4637.4 4847.7 4850.8 4867.7 4921.8 3068.2 3085.4 3092.7 3107.4 3113.8 5431.0 5459.9 5481.4 5482.3 5483.0 5714.7 5943.4 6021.2 6037.3 6045.5 5487.0 5499.6 5510.2 5511.3 5532.2 5743.5 5836.8 5880.1 5880.7 5893.8 5771.2 5787.0 5790.5 5791.7 5803.6 5169.3 5260.7 5349.9 5464.6 5465.2 4051.8 4060.2 4085.2 4089.6 4091.7 5836.2 5840.4 5850.9 5879.9 5883.3 5478.2 5654.2 5657.2 5665.6 5698.1 5652.9 5655.4 5671.1 5676.1 5729.5 5388.7 5613.8 5619.6 5621.6 5635.0 5732.3 5734.2 5736.1 5744.3 5752.6 5535.6 5561.4 5566.2 5566.2 5574.9 18:17:19 INFO - PID 5125 | 18:17:19 INFO - PID 5125 | [#5] yui.html Cycles:180 Average:13609.02 Median:44588.56 stddev:16564.85 (37.2%) stddev-sans-first:16582.46 18:17:19 INFO - PID 5125 | Values: 589.5 598.1 669.5 683.5 697.7 11014.6 11586.8 12055.2 12065.8 12335.5 11837.4 12028.5 12088.9 12100.1 12245.2 811.1 812.7 828.1 833.8 835.8 840.3 849.5 850.4 851.2 851.3 881.7 883.2 883.9 884.9 885.2 870.0 875.8 876.9 877.4 878.5 646.3 647.0 648.6 648.7 649.4 13006.8 13153.7 13170.7 13191.9 13821.1 12815.5 13559.7 13644.5 13823.8 13826.0 9964.5 10227.9 10406.8 10581.4 10610.1 2719.1 2732.5 2736.5 2745.3 2751.5 65358.0 66583.7 67334.7 69279.3 69301.3 10568.3 10585.6 10608.5 10644.1 10809.6 21735.6 21776.7 21779.6 21823.6 21852.3 5954.3 5988.9 6148.1 6229.4 6320.6 3094.9 3154.7 3174.9 3186.3 3314.3 3513.5 3572.4 3585.5 3587.0 3950.8 750.3 755.8 763.6 767.1 777.5 449.9 479.8 488.7 538.2 571.9 8081.7 8356.7 8623.7 8642.0 8756.7 541.4 552.3 555.0 562.5 575.2 3785.5 4006.7 4013.0 4124.2 4156.9 49767.3 62652.1 63469.4 63975.7 66283.0 35671.6 44840.0 46098.0 50998.5 52928.7 44337.1 44886.3 44981.6 46406.8 47282.8 8969.4 9486.7 9504.3 9625.9 9667.1 24677.9 24831.9 25010.7 25500.5 26427.9 24696.9 24864.9 28994.9 29039.4 30165.4 11698.7 11926.3 11936.9 11953.2 12216.9 12548.7 12575.1 12673.2 12716.2 13305.3 11076.7 11260.8 11742.9 11889.6 11895.8 11855.6 12181.4 12300.4 12324.4 12682.9 11149.5 11617.8 11787.9 12098.9 12223.3 8460.5 8677.3 8934.0 8994.4 9170.9 9132.5 9815.8 9853.4 9953.4 9971.2 18:17:19 INFO - PID 5125 | -------- Summary: end -------- 18:17:19 INFO - PID 5125 | 18:17:20 INFO - TEST-INFO | 5125: exit 0 18:17:20 INFO - TEST-OK | dromaeo_css | took 1125558ms 18:17:20 INFO - TEST-START | kraken 18:17:20 INFO - operating with platform_type : linux_ 18:17:20 INFO - Initialising browser for kraken test... 18:17:20 INFO - TEST-INFO | started process 5473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT_stui/profile http://localhost:59093/getInfo.html) 18:17:24 INFO - PID 5473 | __metrics Screen width/height:1600/1200 18:17:24 INFO - PID 5473 | colorDepth:24 18:17:24 INFO - PID 5473 | Browser inner width/height: 1024/697 18:17:24 INFO - PID 5473 | __metrics 18:17:25 ERROR - PID 5473 | 1490663845579 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 18:17:25 INFO - PID 5473 | 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" 18:17:25 INFO - PID 5473 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:17:26 INFO - TEST-INFO | 5473: exit 0 18:17:26 INFO - Browser initialized. 18:17:26 INFO - Running cycle 1/1 for kraken test... 18:17:26 INFO - TEST-INFO | started process 5573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT_stui/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:39 INFO - PID 5573 | RSS: Main: 167006208 18:17:39 INFO - PID 5573 | 18:17:41 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59093/tests/kraken/driver.html?testName=audio-beat-detection) 18:17:42 INFO - PID 5573 | RSS: Main: 226775040 18:17:42 INFO - PID 5573 | 18:17:45 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59093/tests/kraken/driver.html?testName=audio-dft) 18:17:46 INFO - PID 5573 | RSS: Main: 205987840 18:17:46 INFO - PID 5573 | 18:17:49 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59093/tests/kraken/driver.html?testName=audio-fft) 18:17:50 INFO - PID 5573 | RSS: Main: 292110336 18:17:50 INFO - PID 5573 | 18:17:52 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59093/tests/kraken/driver.html?testName=audio-oscillator) 18:17:52 INFO - PID 5573 | RSS: Main: 202420224 18:17:52 INFO - PID 5573 | 18:17:55 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59093/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:17:55 INFO - PID 5573 | RSS: Main: 206200832 18:17:55 INFO - PID 5573 | 18:17:59 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59093/tests/kraken/driver.html?testName=imaging-darkroom) 18:17:59 INFO - PID 5573 | RSS: Main: 243412992 18:17:59 INFO - PID 5573 | 18:18:03 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59093/tests/kraken/driver.html?testName=imaging-desaturate) 18:18:04 INFO - PID 5573 | RSS: Main: 236847104 18:18:04 INFO - PID 5573 | 18:18:07 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59093/tests/kraken/driver.html?testName=json-parse-financial) 18:18:07 INFO - PID 5573 | RSS: Main: 240078848 18:18:07 INFO - PID 5573 | 18:18:09 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59093/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:18:10 INFO - PID 5573 | RSS: Main: 201887744 18:18:10 INFO - PID 5573 | 18:18:11 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:18:12 INFO - PID 5573 | RSS: Main: 210657280 18:18:12 INFO - PID 5573 | 18:18:14 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:18:15 INFO - PID 5573 | RSS: Main: 219193344 18:18:15 INFO - PID 5573 | 18:18:18 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:18:19 INFO - PID 5573 | RSS: Main: 228659200 18:18:19 INFO - PID 5573 | 18:18:22 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:18:23 INFO - PID 5573 | RSS: Main: 225787904 18:18:23 INFO - PID 5573 | 18:18:24 INFO - PID 5573 | Cycle 1(1): loaded http://localhost:59093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59093/tests/kraken/driver.html?testName=ai-astar) 18:18:25 INFO - PID 5573 | RSS: Main: 294961152 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | __start_tp_report 18:18:25 INFO - PID 5573 | _x_x_mozilla_page_load 18:18:25 INFO - PID 5573 | _x_x_mozilla_page_load_details 18:18:25 INFO - PID 5573 | |i|pagename|runs| 18:18:25 INFO - PID 5573 | |0;ai-astar;104;114;112;112;111;114;111;110;111;111 18:18:25 INFO - PID 5573 | |1;audio-beat-detection;159;125;123;166;125;129;129;125;156;131 18:18:25 INFO - PID 5573 | |2;audio-dft;163;163;165;167;164;165;163;165;165;164 18:18:25 INFO - PID 5573 | |3;audio-fft;75;75;76;105;76;75;78;75;92;75 18:18:25 INFO - PID 5573 | |4;audio-oscillator;84;84;107;84;84;85;100;85;85;103 18:18:25 INFO - PID 5573 | |5;imaging-gaussian-blur;114;114;114;113;114;114;114;114;113;114 18:18:25 INFO - PID 5573 | |6;imaging-darkroom;149;152;150;152;152;150;150;149;151;151 18:18:25 INFO - PID 5573 | |7;imaging-desaturate;94;96;94;95;94;94;94;94;96;96 18:18:25 INFO - PID 5573 | |8;json-parse-financial;67;66;66;65;67;71;67;67;66;66 18:18:25 INFO - PID 5573 | |9;json-stringify-tinderbox;56;56;55;55;56;55;55;56;56;56 18:18:25 INFO - PID 5573 | |10;stanford-crypto-aes;82;93;83;93;81;83;82;82;83;83 18:18:25 INFO - PID 5573 | |11;stanford-crypto-ccm;135;136;135;133;141;144;139;133;206;132 18:18:25 INFO - PID 5573 | |12;stanford-crypto-pbkdf2;188;192;194;196;195;195;195;203;195;202 18:18:25 INFO - PID 5573 | |13;stanford-crypto-sha256-iterative;72;72;72;73;70;72;73;71;71;70 18:18:25 INFO - PID 5573 | __end_tp_report 18:18:25 INFO - PID 5573 | __start_cc_report 18:18:25 INFO - PID 5573 | _x_x_mozilla_cycle_collect,2000 18:18:25 INFO - PID 5573 | __end_cc_report 18:18:25 INFO - PID 5573 | __startTimestamp1490663905146__endTimestamp 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | ------- Summary: start ------- 18:18:25 INFO - PID 5573 | Number of tests: 14 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:2.79 (2.5%) stddev-sans-first:1.39 18:18:25 INFO - PID 5573 | Values: 104.0 114.0 112.0 112.0 111.0 114.0 111.0 110.0 111.0 111.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.00 stddev:16.59 (12.8%) stddev-sans-first:15.53 18:18:25 INFO - PID 5573 | Values: 159.0 125.0 123.0 166.0 125.0 129.0 129.0 125.0 156.0 131.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 18:18:25 INFO - PID 5573 | Values: 163.0 163.0 165.0 167.0 164.0 165.0 163.0 165.0 165.0 164.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.50 stddev:10.16 (13.5%) stddev-sans-first:10.60 18:18:25 INFO - PID 5573 | Values: 75.0 75.0 76.0 105.0 76.0 75.0 78.0 75.0 92.0 75.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:9.29 (11.1%) stddev-sans-first:9.59 18:18:25 INFO - PID 5573 | Values: 84.0 84.0 107.0 84.0 84.0 85.0 100.0 85.0 85.0 103.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:18:25 INFO - PID 5573 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:1.17 (0.8%) stddev-sans-first:1.09 18:18:25 INFO - PID 5573 | Values: 149.0 152.0 150.0 152.0 152.0 150.0 150.0 149.0 151.0 151.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 18:18:25 INFO - PID 5573 | Values: 94.0 96.0 94.0 95.0 94.0 94.0 94.0 94.0 96.0 96.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.72 18:18:25 INFO - PID 5573 | Values: 67.0 66.0 66.0 65.0 67.0 71.0 67.0 67.0 66.0 66.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 18:18:25 INFO - PID 5573 | Values: 56.0 56.0 55.0 55.0 56.0 55.0 55.0 56.0 56.0 56.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:4.53 (5.5%) stddev-sans-first:4.71 18:18:25 INFO - PID 5573 | Values: 82.0 93.0 83.0 93.0 81.0 83.0 82.0 82.0 83.0 83.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:137.50 stddev:22.33 (16.2%) stddev-sans-first:23.47 18:18:25 INFO - PID 5573 | Values: 135.0 136.0 135.0 133.0 141.0 144.0 139.0 133.0 206.0 132.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.50 Median:195.00 stddev:4.35 (2.2%) stddev-sans-first:3.67 18:18:25 INFO - PID 5573 | Values: 188.0 192.0 194.0 196.0 195.0 195.0 195.0 203.0 195.0 202.0 18:18:25 INFO - PID 5573 | 18:18:25 INFO - PID 5573 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.07 (1.5%) stddev-sans-first:1.13 18:18:25 INFO - PID 5573 | Values: 72.0 72.0 72.0 73.0 70.0 72.0 73.0 71.0 71.0 70.0 18:18:25 INFO - PID 5573 | -------- Summary: end -------- 18:18:25 INFO - PID 5573 | 18:18:26 INFO - TEST-INFO | 5573: exit 0 18:18:26 INFO - TEST-OK | kraken | took 66009ms 18:18:26 INFO - SUITE-END | took 1191s 18:18:26 INFO - Completed test suite (00:19:51) 18:18:26 INFO - javascript benchmark 18:18:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6543.882503917124, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2734.8495832729204, 2778.5554311310193, 2805.7895657825657, 2809.7471227589513, 2829.54727243641, 5116.565091967178, 5198.974005129979, 5287.65630234035, 5312.707801070945, 5314.89370212596, 5145.511176438242, 5151.845444636667, 5152.536271735543, 5172.534471897528, 5177.042247184274, 4700.012997270569, 4712.246040633499, 4824.951750482503, 4871.732054736988, 4879.853604391857, 4803.807847686106, 4808.2547205183255, 4825.734584597846, 4830.637702172334, 4837.661363704525, 368.91973151744656, 4815.181419158716, 4866.221404575269, 4866.780994855222, 4885.609151267908, 4269.658427325838, 4764.309175169581, 4790.449098353699, 4802.279658051285, 4844.467108618049, 4752.049590081963, 4766.904661906742, 4777.116233496814, 4778.331033655291, 4802.543758342987, 5037.974810125926, 5082.618803589746, 5161.612879034087, 5183.481651834786, 5195.246689230078, 5608.915866262009, 5641.71791410432, 5690.089585666315, 5700.287464066992, 5707.600467967244, 5701.315842098933, 5744.6840423776675, 5748.310202775652, 5752.626079304873, 5755.482006619382, 5381.865453363697, 5388.515033646991, 5413.242146099549, 5415.53967912724, 5418.45815418455, 5732.512736417368, 5809.128630705428, 5810.6513609183585, 5836.941630583725, 5874.706264686749, 5591.329040515164, 5606.1030235163, 5610.242617246701, 5612.382637909826, 5642.548596112301, 5514.310711161105, 5576.386597474275, 5582.63712858671, 5631.6902570359025, 5678.261825962599, 5527.088030475007, 5586.581006424453, 5626.43735626434, 5626.662400255997, 5630.690312032795, 5472.890542189134, 5518.0, 5522.944770552243, 5567.638103523258, 5611.8597035073635, 4609.976950115295, 4644.8374306899095, 4661.510541393172, 4680.789364478606, 4690.061987602425, 3980.5621381647998, 3984.4222587724616, 3995.10110225197, 4014.558398576154, 4038.8788336349958, 4603.723776573416, 4651.395318608627, 4702.435707715096, 4708.152532544106, 4749.26386410107, 5576.442355764391, 5668.943310566841, 5735.856603584861, 5748.252727145528, 5749.9425005750245, 4746.667733258708, 4769.165396055676, 4774.5464180903455, 4776.665633405698, 4820.204666230033, 5034.144195486776, 5036.5718913892, 5062.417821950523, 5064.290999260106, 5110.8466745997675, 5202.583793296603, 5238.371395432572, 5242.475752424727, 5245.344331958505, 5284.075286824714, 5551.0, 5600.187972744011, 5608.327000759935, 5651.773929042793, 5663.3770285267765, 5205.869853253699, 5243.737813109253, 5253.395859476209, 5253.422123566481, 5312.0, 5476.424975377528, 5523.309586301712, 5538.418466061005, 5538.944610553843, 5540.7783688652, 5608.85977850557, 5636.887262254814, 5638.041532939492, 5638.830835074954, 5641.041023026178, 5434.402215756343, 5459.508644222039, 5463.344398672185, 5500.064988951808, 5553.361363443256, 5441.075017247156, 5470.617056805985, 5494.862628434321, 5519.31008623922, 5545.417731138173, 5412.377576578587, 5427.294451721251, 5437.510624043855, 5439.728013599383, 5482.205080263419, 5399.082156033405, 5463.153211252262, 5526.834194974157, 5528.253685752372, 5533.667979921218, 5347.839564813062, 5350.705711185767, 5356.973215133899, 5388.353397592314, 5399.676019438846], "value": 5098.531655157974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.5919166883208, 726.6984201556353, 1062.3413483640145, 1082.631905152248, 1083.7669900971289, 30697.846510767442, 31516.842415787916, 31527.211819704462, 31582.368352632933, 31593.84203078987, 33646.32707345852, 34027.82986085066, 34109.65890341096, 34120.31759364811, 34129.31741365171, 5582.078956972095, 7267.454940879429, 7398.926010739904, 7401.296876796696, 7410.851782964338, 5514.724263786815, 7098.254683258261, 7323.340899319061, 7327.340539351458, 7330.083739532559, 7408.370288525455, 7454.664540095681, 7458.664360103781, 7463.626818659072, 7467.215942326059, 7357.117145942468, 7417.184109747924, 7417.851642967111, 7420.146683131455, 7427.220141885078, 7268.273172682742, 7311.744088956914, 7439.330460258603, 7441.032665753418, 7454.40364770817, 32111.839440802647, 32323.353532929446, 32354.0, 32356.83821580877, 32376.0, 2578.1234380310784, 2606.960895586568, 2612.7256638052922, 2663.840169589831, 2683.154806236049, 20988.685169722467, 21138.788612113836, 21243.25648602307, 22226.666600001012, 22245.332640020664, 2957.5859379686863, 2975.0628552006265, 2976.0922918509846, 3005.443992861328, 3069.3247485553143, 138163.0, 138621.14825981043, 139252.0, 139256.0, 140145.299273504, 32060.19849503781, 32666.510002349984, 40218.59781402207, 40374.59625403767, 40432.79783601063, 39505.40741888874, 40049.39925901114, 40087.0, 40298.79850600728, 40319.39520907189, 11694.122940779305, 11702.356370399539, 11802.055835533136, 11804.76390472203, 12013.219140755822, 9245.075492450836, 9252.722418327461, 9283.303752218611, 9331.393459425115, 9470.0, 13291.734165316639, 13295.800562991562, 13306.73386532264, 13344.399502022432, 13543.796843047363, 5401.4868587484125, 5445.782168713286, 5544.445555444504, 5559.416261292587, 5587.357453892773, 891.3003292415423, 901.8647202919615, 917.8760867282831, 918.7151982885193, 922.9907700923039, 19829.0, 20650.27724029682, 21009.78990210109, 21096.261630842848, 21495.140194392363, 983.3116818227127, 986.8371718666483, 987.3236832769576, 987.53585814667, 987.8123156600367, 10600.787984240425, 10832.24174307791, 11064.446777661085, 11081.889181108085, 11084.390358530198, 248294.0, 250300.0, 250324.0, 250431.0, 250797.0, 42140.578594214276, 42388.78805605952, 42458.36312455316, 42487.36268955968, 42512.78743606324, 1215.4469716279073, 1248.9687757805946, 1262.9810552841714, 1264.5321231144535, 1267.8478582569967, 19296.61406771885, 19907.0, 20039.398818035483, 20231.291904783262, 20584.897075514527, 29926.70073299239, 30137.09588712342, 30139.3972120552, 30150.0, 30166.0, 223577.0, 223721.0, 225562.16567515003, 225737.0, 225754.0, 28172.0, 28563.714362856106, 28595.0, 28657.570136447554, 28667.0, 34405.0, 34539.4819077709, 34751.826240868635, 35318.117047074025, 35360.469592956644, 27820.30449238785, 28027.159185224475, 28260.43479130447, 29308.0, 29940.550891736206, 29868.85065574745, 30157.547636785905, 30495.237619059702, 30654.846725766227, 31190.22024449316, 34278.65721342755, 34559.82720086384, 35115.0, 35130.82434587811, 35139.82430087833, 29936.101916942527, 29939.401211976074, 30431.54352684756, 30876.845615772676, 31131.462392897745, 23503.764962350157, 23766.168184113474, 23892.0, 24048.51902961966, 24261.180411468857], "value": 14835.987251940132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.74537178148324, 418.52407000058395, 432.44214962698123, 434.5979968529111, 444.69538366219143, 13555.864441355583, 17485.912570437147, 17622.0, 18472.722909156375, 18531.444056678287, 18296.268149274045, 18405.355812546564, 18564.907175464105, 18675.43973680792, 18918.527036824053, 5460.836174914759, 5720.79977200798, 5720.8855822883515, 5729.026065568843, 5731.168980497825, 3324.4182268102986, 3496.5804103507617, 5397.595180361469, 5570.053090974524, 5622.128570071645, 5622.072358060936, 5625.128105143709, 5627.662340259598, 5628.465295796893, 5628.493435590796, 5381.784728610871, 5607.186957891124, 5618.550515958734, 5622.943770562283, 5636.436356364372, 5081.364829396325, 5082.288479612857, 5082.669626474304, 5085.0, 5089.287499750038, 20647.380578582666, 21439.785602143937, 21483.0, 21519.246826361003, 21541.892290538603, 1500.354847415611, 1501.3469140923623, 1504.488473918862, 1512.6294057955872, 1528.678977414733, 13393.66515837102, 13440.395182216824, 13555.661108472268, 13588.456461741518, 14174.645633859132, 1529.9388024479008, 1532.0807515490728, 1538.96152596186, 1550.9922450387676, 1569.5291412576296, 76266.61866690687, 76605.61697191479, 76763.0, 77473.0, 79163.6041819793, 9095.49974751395, 10348.793024139475, 10753.408562528979, 10778.94610526958, 10976.0, 13149.408276627575, 13186.868131318755, 13905.930470347583, 14374.425022998963, 14375.712485750435, 7269.091363579552, 7324.707011719578, 7385.335319821134, 7415.221401752846, 7486.363659089038, 6535.8692826143215, 6633.369829866155, 6765.932340676629, 6786.898196527056, 6790.185177778698, 6772.458203343721, 6785.762498312634, 6795.694193761293, 6941.939162189937, 7017.157941047107, 1966.3609326968506, 2000.779914209436, 2025.9363833987275, 2027.178992508007, 2039.439154232598, 869.1091631078195, 904.1049361132563, 904.8054668246359, 906.1074841281333, 923.5428462910768, 16252.0, 16268.837311626969, 16858.157092145342, 16871.662566748597, 17067.743983840253, 902.0798785239151, 907.732218995398, 913.1279627955287, 918.1094338491653, 927.2923064651235, 8769.868451973225, 8845.911540884508, 9327.486988215713, 9547.2839537035, 9575.616975321049, 453200.0, 454325.0, 456264.4373556222, 459404.0, 462451.0, 80631.59684201659, 83027.58486207531, 84041.57979210065, 85140.57429712811, 85536.0, 1046.3721766939775, 1075.1184029096223, 1100.7688385438987, 1102.5479553383075, 1105.0551778229499, 14035.929820350833, 14211.715765684836, 14216.431342746175, 14380.705736483767, 14908.180050096915, 40131.0, 41871.1625767489, 43393.56606433895, 44833.775831120634, 45457.77271113623, 54107.18839217494, 55513.444865550824, 56113.0, 56343.43656563382, 58554.12168817386, 7622.352100071556, 7637.694492220249, 7907.2488113629115, 8068.354531637572, 8125.212453260273, 11068.612598559333, 11396.544138234378, 11482.253653512495, 11844.70388240301, 11853.466594003117, 9121.179093881583, 9250.259979201513, 9288.674896378594, 9421.764455888657, 9539.998300178382, 9376.531173441164, 9392.154706076486, 9406.247500200105, 9458.148766611039, 9493.525323733924, 9641.951790241004, 9644.469554174308, 9866.309358344846, 9997.800043999225, 10059.74850628711, 7489.962550187214, 7529.171791103084, 7579.924200757921, 7627.466077374531, 7726.227377262454, 9619.903800961902, 9662.806743864943, 9745.463999480096, 9906.950465247915, 10131.544080516247], "value": 8520.670431972727, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.1562576512385, 1331.6737399337164, 1332.7334533093383, 1351.6755978565145, 1356.5184359552359, 9367.578458969345, 9698.854517182248, 9699.951500242507, 9746.805063898717, 9751.951240243807, 9539.666111686092, 9609.0, 9900.50497475127, 9901.356411833243, 9903.15823155031, 2237.854539454934, 2263.207877242968, 2266.0822366941416, 2266.9659955100606, 2269.183094086136, 2081.438011736838, 2200.2189222825905, 2217.8558393704357, 2222.4999375140546, 2227.498812767131, 1907.818757218062, 1974.0820518458913, 2172.7935846094597, 2247.539254452833, 2251.5722012817514, 2257.6500642400456, 2276.521930394619, 2276.7267927848766, 2277.6583512473094, 2279.7150356205475, 2170.4139882231866, 2193.583219188365, 2214.4574579228033, 2220.1563405905813, 2220.811231045363, 9550.856737148948, 9621.615135394575, 9629.085236902552, 9630.47032413217, 9892.703218903445, 5461.42655021225, 5641.774329026834, 5646.915296270559, 5649.661020338752, 5655.1799989001365, 3061.7397521210723, 3243.918902027445, 3325.800451972865, 3339.5658564386476, 3346.9330613387597, 923.8290916180528, 970.2480577552383, 989.7624570103123, 1000.1099021870541, 1002.8746406699163, 14116.717665646733, 14268.643283917881, 14274.92862535691, 14296.285185740671, 14298.0, 4811.27830825372, 4903.313536104948, 5000.974995125001, 5030.773615187325, 5074.974625126851, 10768.78462430747, 10899.346039237513, 10924.18068644839, 10925.344479331106, 10927.180461465263, 5503.559715222773, 5508.779648814003, 5516.310461192351, 5517.420670829585, 5519.586031047687, 4970.751462426864, 5112.667676601009, 5174.508421699932, 5207.166853303529, 5217.243499692523, 3738.775673459601, 3903.2974064668633, 3933.0, 3946.151577410813, 4008.819603117867, 1125.6530134669306, 1133.3030186435283, 1134.7276653603076, 1147.0995268714018, 1152.4986630815622, 560.095798327344, 698.4970821008866, 703.4056222491986, 705.5590256089944, 722.819295176206, 5288.0, 5338.3593968724, 5507.476789704971, 5532.3914369419335, 5600.663960162403, 816.1063635319316, 832.1844592299581, 837.2632083766368, 837.8952630921135, 851.5061264466594, 3444.9655503445147, 3484.738644601665, 3609.0796846803896, 3616.8010759408485, 3762.6613604775703, 11954.521819127138, 12570.371481425893, 12968.481260749653, 12982.610521684364, 12990.805137922938, 12766.489340426278, 12979.935100324437, 12983.805242921364, 12989.480420783251, 13001.804972925414, 9185.63257469707, 9385.263726210536, 9403.200727938201, 9415.105564971316, 9430.811383772287, 5354.250404943233, 5370.060239458001, 5421.864453388539, 5621.381648018796, 5892.381299963614, 11171.329720216812, 11353.943230283796, 11460.255083419552, 11506.252093613888, 11590.362530060927, 11639.127065469955, 11663.941680291544, 11695.707607309885, 11719.88280117188, 11826.763464730486, 8009.279164875189, 8118.0, 8197.549134797644, 8207.056188538394, 8210.794730131794, 8767.430117042626, 8912.197902188835, 8940.821183576161, 9001.279897608307, 9020.59407326685, 7502.549847009197, 7536.585487798224, 7567.243275672609, 7686.231376862269, 7807.375409967075, 7313.195548489555, 7434.73978410753, 7439.330460258603, 7459.291367320096, 7488.5506869588, 6786.0838786765125, 6982.895256571257, 7129.928700713134, 7172.677229524788, 7179.066721326194, 4704.176769065331, 4724.976375118103, 4747.8575642730775, 4767.261074533453, 4873.122837889072, 5067.214581739836, 5142.151544995184, 5208.270842082187, 5213.947860521346, 5233.110371236823], "value": 4641.331919223885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.0939185178165, 394.39263534157396, 395.3318891074085, 397.57459518315403, 405.57617289932017, 5226.189940559215, 5336.839894803153, 5346.304980352549, 5383.703896285702, 5391.838244852661, 5097.286379906806, 5218.895622087556, 5220.425753167148, 5282.867928301795, 5285.630005899579, 4232.841250962017, 4243.787810609472, 4251.723637963538, 4265.722728022684, 4274.764887931163, 4239.682023848209, 4245.129748401586, 4254.361845723135, 4256.255155347817, 4269.807858646368, 4132.814023368941, 4227.112306415641, 4241.639460645849, 4246.872593822175, 4253.787310634471, 4191.8532851350365, 4215.199112168678, 4218.282891908383, 4220.810063547117, 4227.830886764541, 3805.1818858945185, 3812.2566099610585, 3816.7519111257957, 3819.1788765415567, 3823.7323387362894, 5105.0, 5106.64253502255, 5107.387113546361, 5108.208227724708, 5130.9230361544605, 4502.144592527442, 4688.460827004904, 4731.597814185799, 4735.763211839429, 4758.262469317261, 5638.35158956717, 5641.18202860587, 5648.209250704905, 5650.333151720252, 5658.0, 3986.740861843971, 3990.68074554035, 4006.258842114189, 4008.0, 4016.3172260715455, 5615.097507232475, 5696.857578560569, 5767.625104368287, 5820.5634577406445, 5968.731407086691, 4045.6561192298986, 4059.167870586523, 4067.6407683543475, 4079.224947260011, 4084.244414783275, 4128.8348466061025, 4133.821860769726, 4136.152088821785, 4143.606357396043, 4145.481814773153, 4467.776611169428, 4486.147631949984, 4582.518835522222, 4744.976275118672, 4762.9523704762505, 5624.915626265528, 5632.690202038927, 5636.859078522988, 5637.8590535236945, 5674.0, 1411.5906387147613, 1425.6222101143205, 1436.5187662133303, 1437.1018113678952, 1438.3455527734855, 956.6460409648474, 957.3729207369184, 964.0, 974.7124598243536, 981.651513712636, 4859.343988561499, 4893.09477746618, 4899.191633380524, 4899.407692499952, 4899.755012249373, 5813.447722466359, 5824.88350232993, 5847.26909136358, 5849.561282903799, 5872.941270587325, 4637.350770892078, 4847.660663753574, 4850.80596776125, 4867.7322747249245, 4921.803127874845, 3068.156257029335, 3085.441851864794, 3092.716522643123, 3107.409592177479, 3113.754498200738, 5430.972845135749, 5459.918101228484, 5481.355593322067, 5482.259894914216, 5483.0, 5714.685692286964, 5943.435373639584, 6021.157038014681, 6037.275526936708, 6045.486133678686, 5487.012337779158, 5499.587530935196, 5510.173473978935, 5511.338639363302, 5532.225488431623, 5743.540516758733, 5836.795712150054, 5880.117982302518, 5880.7356418368545, 5893.764249429974, 5771.1920331154515, 5786.971065144648, 5790.536757059341, 5791.710414479175, 5803.564732644984, 5169.327987361619, 5260.684358938476, 5349.866253343697, 5464.590155738256, 5465.207544905887, 4051.8379264829077, 4060.2488539620263, 4085.22380747657, 4089.5705950875918, 4091.693123015726, 5836.241288632451, 5840.393891679822, 5850.94149058504, 5879.941200587939, 5883.323417807007, 5478.205660179172, 5654.180143879197, 5657.2079908811975, 5665.631733937281, 5698.088305871041, 5652.943470565242, 5655.406182350794, 5671.149327600893, 5676.120201368794, 5729.512991395778, 5388.676679399248, 5613.775448981995, 5619.634723742944, 5621.606487545832, 5635.0, 5732.283464566929, 5734.2258795062135, 5736.082226843685, 5744.281964754406, 5752.568557358131, 5535.612507124623, 5561.443855614406, 5566.165075238585, 5566.220729097849, 5574.888502230014], "value": 4266.920372914854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5195415736177, 598.1177762799869, 669.4945316286203, 683.4525248122982, 697.6755808549024, 11014.559417623295, 11586.82619760702, 12055.156139070268, 12065.758684826298, 12335.506579736822, 11837.408129593507, 12028.51885924562, 12088.939555302233, 12100.092493063012, 12245.204061736003, 811.1077814404138, 812.7033632724043, 828.0642873552877, 833.8499070167368, 835.7952301686065, 840.315143158324, 849.46908182386, 850.3664769746548, 851.2423942691009, 851.276415047208, 881.6517475597135, 883.2007033634571, 883.9469631822111, 884.8938127424718, 885.1944730295432, 870.0429527519741, 875.7722992022057, 876.925461335784, 877.368294827723, 878.547548012774, 646.2761706888268, 646.9902951455732, 648.5524987758431, 648.6951132967498, 649.3571364349308, 13006.804897926539, 13153.671158221025, 13170.736585268241, 13191.934040329834, 13821.101628394123, 12815.487380504768, 13559.661008474768, 13644.454221831214, 13823.78526158817, 13826.0, 9964.451955142464, 10227.948860255725, 10406.84389734147, 10581.418022008786, 10610.098141657969, 2719.1298784389005, 2732.4671689020647, 2736.5484695025298, 2745.341118131634, 2751.490974169785, 65358.0, 66583.66708166429, 67334.66332668305, 69279.30720692778, 69301.30698693, 10568.313059651098, 10585.629502967358, 10608.461534640352, 10644.148468122532, 10809.567617295377, 21735.56528869414, 21776.673349899764, 21779.564408712053, 21823.563528729337, 21852.344429667137, 5954.345022047572, 5988.850278742979, 6148.1392605035335, 6229.408206220402, 6320.5575609706875, 3094.8916787912767, 3154.7160755531654, 3174.920626984344, 3186.2512309607223, 3314.254292784104, 3513.508108864761, 3572.374834403969, 3585.515955345995, 3586.9597816632886, 3950.822213000422, 750.312215461003, 755.7543798265476, 763.6143747407524, 767.0795045944889, 777.4596655324608, 449.91901457737265, 479.7864950097173, 488.7067759344436, 538.1953978801638, 571.8827640333805, 8081.717139900193, 8356.746488026845, 8623.698170564126, 8641.956790216009, 8756.693515726918, 541.4477233222092, 552.2737600055914, 554.9805756798493, 562.5274769193896, 575.203343369428, 3785.5268091488565, 4006.719529632956, 4012.9799351003057, 4124.175164967019, 4156.937645935313, 49767.253491196934, 62652.06021909675, 63469.36530634727, 63975.68012159909, 66283.0, 35671.64328356735, 44840.0, 46098.0, 50998.49001509937, 52928.73535632297, 44337.113257734665, 44886.32670509945, 44981.55018449773, 46406.767966159954, 47282.76358618185, 8969.37214394986, 9486.667966621411, 9504.267729210214, 9625.855612165684, 9667.129958303787, 24677.876610616833, 24831.87584062068, 25010.74989250084, 25500.48999019972, 26427.867860660575, 24696.876515617307, 24864.875675621504, 28994.85502572558, 29039.419211615226, 30165.396692066475, 11698.737864560047, 11926.284422934652, 11936.880631193924, 11953.163278570417, 12216.877831221575, 12548.749025019632, 12575.119741617998, 12673.17624354414, 12716.173448725804, 13305.268210248529, 11076.723081923017, 11260.83108753353, 11742.882571174521, 11889.583864564698, 11895.762084758084, 11855.58505452305, 12181.39093045362, 12300.446479908605, 12324.383780811102, 12682.936585317015, 11149.498272577592, 11617.76764464689, 11787.882121178678, 12098.879011209776, 12223.266604003788, 8460.534670593177, 8677.262432693291, 8934.0, 8994.415363001384, 9170.908290917005, 9132.543372831198, 9815.823039242288, 9853.359531630422, 9953.402795832273, 9971.152452041368], "value": 6151.588644277072, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 112.0, 112.0, 111.0, 114.0, 111.0, 110.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 123.0, 166.0, 125.0, 129.0, 129.0, 125.0, 156.0, 131.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 167.0, 164.0, 165.0, 163.0, 165.0, 165.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 76.0, 75.0, 78.0, 75.0, 92.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 107.0, 84.0, 84.0, 85.0, 100.0, 85.0, 85.0, 103.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 150.0, 152.0, 152.0, 150.0, 150.0, 149.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 96.0, 96.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 67.0, 71.0, 67.0, 67.0, 66.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 93.0, 83.0, 93.0, 81.0, 83.0, 82.0, 82.0, 83.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 135.0, 133.0, 141.0, 144.0, 139.0, 133.0, 206.0, 132.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 192.0, 194.0, 196.0, 195.0, 195.0, 195.0, 203.0, 195.0, 202.0], "value": 195.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 70.0, 72.0, 73.0, 71.0, 71.0, 70.0], "value": 71.6, "unit": "score"}]}]} 18:18:26 INFO - Return code: 0 18:18:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:18:26 ERROR - # TBPL SUCCESS # 18:18:26 INFO - Running post-action listener: _resource_record_post_action 18:18:26 INFO - [mozharness: 2017-03-28 01:18:26.945940Z] Finished run-tests step (success) 18:18:26 INFO - Running post-run listener: _resource_record_post_run 18:18:27 INFO - Total resource usage - Wall time: 1208s; CPU: 13.0%; Read bytes: 8192; Write bytes: 377700352; Read time: 168; Write time: 203660 18:18:27 INFO - TinderboxPrint: CPU usage
13.0% 18:18:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 18:18:27 INFO - TinderboxPrint: I/O write bytes / time
377,700,352 / 203,660 18:18:27 INFO - TinderboxPrint: CPU idle
8,385.4 (87.0%) 18:18:27 INFO - TinderboxPrint: CPU user
1,207.6 (12.5%) 18:18:27 INFO - TinderboxPrint: Swap in / out
0 / 0 18:18:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114774016; Read time: 0; Write time: 86260 18:18:27 INFO - run-tests - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 262926336; Read time: 156; Write time: 117400 18:18:27 INFO - Running post-run listener: _upload_blobber_files 18:18:27 INFO - Blob upload gear active. 18:18:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:18:27 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 18:18:27 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'] 18:18:27 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 18:18:28 INFO - (blobuploader) - INFO - Open directory for files ... 18:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:28 INFO - (blobuploader) - INFO - Done attempting. 18:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:32 INFO - (blobuploader) - INFO - Done attempting. 18:18:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:18:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:32 INFO - (blobuploader) - INFO - Done attempting. 18:18:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:18:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:18:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:33 INFO - (blobuploader) - INFO - Done attempting. 18:18:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:18:33 INFO - Return code: 0 18:18:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:18:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:18:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbfe6f6cba8706fab16888b5c0bae6be0a41eab222649a48946a20f24e76cba5071555afb392727a25b820804eef46844626ce42d4ba15ccc3963973ea70eeef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bbcc0b62b8d1a30fdea4c349208698ed1b8e1936ca23dd26a27a111e71ae6bf0f9140a1c72d13e129865accd20dd043e685132b752c4c50da462fd1941d80f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8adad81aaab1391bbb0c50b2a5d721128a85bc64b329dd720642a34eec3024f461b69b5df523890dec40d6c46184b5efaa4de79615f40e145f9b9c7f95f2711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af8b9d79fd76252be1a831e977da8905f239c599921253c200a2cd047276b91f801ddf53a7d8b3e8bb644c86eefe7d0ac522f3e9a95fdaec8a5ab78c0bab80e"} 18:18:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:18:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:18:33 INFO - Contents: 18:18:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbfe6f6cba8706fab16888b5c0bae6be0a41eab222649a48946a20f24e76cba5071555afb392727a25b820804eef46844626ce42d4ba15ccc3963973ea70eeef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bbcc0b62b8d1a30fdea4c349208698ed1b8e1936ca23dd26a27a111e71ae6bf0f9140a1c72d13e129865accd20dd043e685132b752c4c50da462fd1941d80f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8adad81aaab1391bbb0c50b2a5d721128a85bc64b329dd720642a34eec3024f461b69b5df523890dec40d6c46184b5efaa4de79615f40e145f9b9c7f95f2711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af8b9d79fd76252be1a831e977da8905f239c599921253c200a2cd047276b91f801ddf53a7d8b3e8bb644c86eefe7d0ac522f3e9a95fdaec8a5ab78c0bab80e"} 18:18:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:18:33 INFO - Copying logs to upload dir... 18:18:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:18:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.681739 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-03-27 18:18:33.151340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 18:18:33.156517) ========= 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=9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032 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/bbfe6f6cba8706fab16888b5c0bae6be0a41eab222649a48946a20f24e76cba5071555afb392727a25b820804eef46844626ce42d4ba15ccc3963973ea70eeef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bbcc0b62b8d1a30fdea4c349208698ed1b8e1936ca23dd26a27a111e71ae6bf0f9140a1c72d13e129865accd20dd043e685132b752c4c50da462fd1941d80f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8adad81aaab1391bbb0c50b2a5d721128a85bc64b329dd720642a34eec3024f461b69b5df523890dec40d6c46184b5efaa4de79615f40e145f9b9c7f95f2711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af8b9d79fd76252be1a831e977da8905f239c599921253c200a2cd047276b91f801ddf53a7d8b3e8bb644c86eefe7d0ac522f3e9a95fdaec8a5ab78c0bab80e"} build_url:https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/IGW5s5OtTaWhZoL7elDjAQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbfe6f6cba8706fab16888b5c0bae6be0a41eab222649a48946a20f24e76cba5071555afb392727a25b820804eef46844626ce42d4ba15ccc3963973ea70eeef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bbcc0b62b8d1a30fdea4c349208698ed1b8e1936ca23dd26a27a111e71ae6bf0f9140a1c72d13e129865accd20dd043e685132b752c4c50da462fd1941d80f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8adad81aaab1391bbb0c50b2a5d721128a85bc64b329dd720642a34eec3024f461b69b5df523890dec40d6c46184b5efaa4de79615f40e145f9b9c7f95f2711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af8b9d79fd76252be1a831e977da8905f239c599921253c200a2cd047276b91f801ddf53a7d8b3e8bb644c86eefe7d0ac522f3e9a95fdaec8a5ab78c0bab80e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 18:18:33.181534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 18:18:33.181849) ========= 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=9bfb7e13875ed353a705960e000001c0-1490662644.903028-277505032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 18:18:33.265854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 18:18:33.266181) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 18:18:33.266457) ========= ========= Total master_lag: 0.15 =========