builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-089 starttime: 1488734025.37 results: success (0) revision: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.371556) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.372094) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.372643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.404033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.404341) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-05 09:13:45-- 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% 223M=0s 2017-03-05 09:13:46 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.575145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.575841) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020453 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.630138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:45.630932) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b6a130cc3424f17b07220bd23c2c70c4f32e860 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b6a130cc3424f17b07220bd23c2c70c4f32e860 --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=8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-05 09:13:46,258 truncating revision to first 12 chars 2017-03-05 09:13:46,258 Setting DEBUG logging. 2017-03-05 09:13:46,258 attempt 1/10 2017-03-05 09:13:46,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b6a130cc342?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 09:13:46,752 unpacking tar archive at: mozilla-aurora-4b6a130cc342/testing/mozharness/ program finished with exit code 0 elapsedTime=0.903472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:46.551972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:46.552354) ========= script_repo_revision: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:46.552873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:46.553214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 09:13:46.562915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-03-05 09:13:46.563226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:13:47 INFO - MultiFileLogger online at 20170305 09:13:47 in /builds/slave/test 09:13:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:13:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:13:47 INFO - {'append_to_log': False, 09:13:47 INFO - 'base_work_dir': '/builds/slave/test', 09:13:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:13:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:13:47 INFO - 'branch': 'Mozilla-Aurora', 09:13:47 INFO - 'buildbot_json_path': 'buildprops.json', 09:13:47 INFO - 'config_files': ('talos/linux_config.py',), 09:13:47 INFO - 'default_actions': ('clobber', 09:13:47 INFO - 'read-buildbot-config', 09:13:47 INFO - 'download-and-extract', 09:13:47 INFO - 'populate-webroot', 09:13:47 INFO - 'create-virtualenv', 09:13:47 INFO - 'install', 09:13:47 INFO - 'run-tests'), 09:13:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:13:47 INFO - 'download_minidump_stackwalk': True, 09:13:47 INFO - 'download_symbols': 'ondemand', 09:13:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:13:47 INFO - 'tooltool.py': '/tools/tooltool.py', 09:13:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:13:47 INFO - '/tools/misc-python/virtualenv.py')}, 09:13:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:13:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:13:47 INFO - 'installer_path': 'installer.exe', 09:13:47 INFO - 'log_level': 'info', 09:13:47 INFO - 'log_name': 'talos', 09:13:47 INFO - 'log_to_console': True, 09:13:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:13:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:13:47 INFO - 'opt_config_files': (), 09:13:47 INFO - 'pip_index': False, 09:13:47 INFO - 'sps_profile': False, 09:13:47 INFO - 'sps_profile_interval': 0, 09:13:47 INFO - 'suite': 'dromaeojs', 09:13:47 INFO - 'system_bits': '32', 09:13:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:13:47 INFO - 'title': 'talos-linux64-ix-089', 09:13:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:13:47 INFO - 'use_talos_json': True, 09:13:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:13:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:13:47 INFO - 'work_dir': 'build'} 09:13:47 INFO - [mozharness: 2017-03-05 17:13:47.284681Z] Running clobber step. 09:13:47 INFO - Running pre-action listener: _resource_record_pre_action 09:13:47 INFO - Running main action method: clobber 09:13:47 INFO - rmtree: /builds/slave/test/build 09:13:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:13:48 INFO - Running post-action listener: _resource_record_post_action 09:13:48 INFO - [mozharness: 2017-03-05 17:13:48.198413Z] Finished clobber step (success) 09:13:48 INFO - [mozharness: 2017-03-05 17:13:48.198512Z] Running read-buildbot-config step. 09:13:48 INFO - Running pre-action listener: _resource_record_pre_action 09:13:48 INFO - Running main action method: read_buildbot_config 09:13:48 INFO - Using buildbot properties: 09:13:48 INFO - { 09:13:48 INFO - "project": "", 09:13:48 INFO - "product": "firefox", 09:13:48 INFO - "who": "kgupta@mozilla.com", 09:13:48 INFO - "installer_path": "public/build/target.tar.bz2", 09:13:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:13:48 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:13:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:13:48 INFO - "stage_platform": "linux64-pgo", 09:13:48 INFO - "basedir": "/builds/slave/test", 09:13:48 INFO - "buildnumber": 813, 09:13:48 INFO - "platform": "ubuntu64_hw", 09:13:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:13:48 INFO - "slavebuilddir": "test", 09:13:48 INFO - "taskId": "ElptCCLaTtuSNErob2uYDA", 09:13:48 INFO - "branch": "mozilla-aurora", 09:13:48 INFO - "script_repo_revision": "production", 09:13:48 INFO - "revision": "4b6a130cc3424f17b07220bd23c2c70c4f32e860", 09:13:48 INFO - "slavename": "talos-linux64-ix-089", 09:13:48 INFO - "repo_path": "releases/mozilla-aurora" 09:13:48 INFO - } 09:13:48 INFO - Finding installer, test and symbols from parent task. 09:13:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ElptCCLaTtuSNErob2uYDA'}, attempt #1 09:13:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ElptCCLaTtuSNErob2uYDA'}, attempt #1 09:13:49 INFO - Task dependencies: HVbmf-WUSWmdi_YxZHbQKQ 09:13:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ'}, attempt #1 09:13:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2 09:13:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/test_packages.json 09:13:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.crashreporter-symbols.zip 09:13:49 INFO - Running post-action listener: _resource_record_post_action 09:13:49 INFO - [mozharness: 2017-03-05 17:13:49.570523Z] Finished read-buildbot-config step (success) 09:13:49 INFO - [mozharness: 2017-03-05 17:13:49.570741Z] Running download-and-extract step. 09:13:49 INFO - Running pre-action listener: _resource_record_pre_action 09:13:49 INFO - Running main action method: download_and_extract 09:13:49 INFO - mkdir: /builds/slave/test/build/tests 09:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:49 INFO - trying https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.test_packages.json 09:13:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:13:50 INFO - Downloaded 896 bytes. 09:13:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:13:50 INFO - Using the following test package requirements: 09:13:50 INFO - {u'common': [u'target.common.tests.zip'], 09:13:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:13:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:13:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:13:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:13:50 INFO - u'mozbase': [u'target.common.tests.zip'], 09:13:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:13:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:13:50 INFO - u'web-platform': [u'target.common.tests.zip', 09:13:50 INFO - u'target.web-platform.tests.zip'], 09:13:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:13:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:13:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.common.tests.zip 09:13:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:13:50 INFO - Fetch https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.common.tests.zip into memory 09:13:50 INFO - Expected file size: 21861876 09:13:50 INFO - Obtained file size: 21861876 09:13:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:13:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.common.tests.zip 09:13:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:13:55 INFO - Fetch https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.common.tests.zip into memory 09:13:55 INFO - Expected file size: 21861876 09:13:55 INFO - Obtained file size: 21861876 09:14:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.talos.tests.zip 09:14:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:14:00 INFO - Fetch https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.talos.tests.zip into memory 09:14:01 INFO - Expected file size: 14403650 09:14:01 INFO - Obtained file size: 14403650 09:14: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')]} 09:14:01 INFO - trying https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2 09:14:01 INFO - Downloading https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:14:02 INFO - Downloaded 66129611 bytes. 09:14:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2 09:14:02 INFO - mkdir: /builds/slave/test/properties 09:14:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:02 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:02 INFO - Contents: 09:14:02 INFO - build_url:https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2 09:14:02 INFO - Running post-action listener: _resource_record_post_action 09:14:02 INFO - Running post-action listener: set_extra_try_arguments 09:14:02 INFO - [mozharness: 2017-03-05 17:14:02.534463Z] Finished download-and-extract step (success) 09:14:02 INFO - [mozharness: 2017-03-05 17:14:02.534559Z] Running populate-webroot step. 09:14:02 INFO - Running pre-action listener: _resource_record_pre_action 09:14:02 INFO - Running main action method: populate_webroot 09:14:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:02 INFO - '--tppagecycles', 09:14:02 INFO - '7'], 09:14:02 INFO - 'tests': ['tsvgm']}}, 09:14:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:14:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:14:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:14:02 INFO - 'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:14:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:14:02 INFO - 'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['damp', 'tps']}, 09:14:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:14:02 INFO - 'tests': ['damp', 'tps']}, 09:14:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['dromaeo_dom']}, 09:14:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['basic_compositor_video']}, 09:14:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:14:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['a11yr', 09:14:02 INFO - 'ts_paint', 09:14:02 INFO - 'tpaint', 09:14:02 INFO - 'sessionrestore', 09:14:02 INFO - 'sessionrestore_no_auto_restore', 09:14:02 INFO - 'tabpaint']}, 09:14:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:14:02 INFO - 'ts_paint', 09:14:02 INFO - 'tpaint', 09:14:02 INFO - 'sessionrestore', 09:14:02 INFO - 'sessionrestore_no_auto_restore', 09:14:02 INFO - 'tabpaint']}, 09:14:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:14:02 INFO - 'ts_paint', 09:14:02 INFO - 'tpaint', 09:14:02 INFO - 'sessionrestore', 09:14:02 INFO - 'sessionrestore_no_auto_restore', 09:14:02 INFO - 'tabpaint']}, 09:14:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:14:02 INFO - 'ts_paint', 09:14:02 INFO - 'tpaint', 09:14:02 INFO - 'sessionrestore', 09:14:02 INFO - 'sessionrestore_no_auto_restore', 09:14:02 INFO - 'tabpaint']}, 09:14:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['a11yr', 09:14:02 INFO - 'ts_paint', 09:14:02 INFO - 'tpaint', 09:14:02 INFO - 'sessionrestore', 09:14:02 INFO - 'sessionrestore_no_auto_restore', 09:14:02 INFO - 'tabpaint']}, 09:14:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['a11yr', 09:14:02 INFO - 'ts_paint', 09:14:02 INFO - 'tpaint', 09:14:02 INFO - 'sessionrestore', 09:14:02 INFO - 'sessionrestore_no_auto_restore', 09:14:02 INFO - 'tabpaint']}, 09:14:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['tsvgx', 09:14:02 INFO - 'tsvgr_opacity', 09:14:02 INFO - 'tart', 09:14:02 INFO - 'tscrollx', 09:14:02 INFO - 'cart', 09:14:02 INFO - 'tsvg_static']}, 09:14:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:14:02 INFO - 'tsvgr_opacity', 09:14:02 INFO - 'tart', 09:14:02 INFO - 'tscrollx', 09:14:02 INFO - 'cart', 09:14:02 INFO - 'tsvg_static']}, 09:14:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:14:02 INFO - 'talos_options': ['--disable-e10s'], 09:14:02 INFO - 'tests': ['tp5o']}, 09:14:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:14:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:14:02 INFO - 'talos_options': ['--disable-e10s', 09:14:02 INFO - '--xperf_path', 09:14:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:02 INFO - 'tests': ['tp5n']}, 09:14:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:14:02 INFO - 'talos_options': ['--xperf_path', 09:14:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:02 INFO - 'tests': ['tp5n']}}, 09:14:02 INFO - 'talos.zip': {'path': '', 09:14:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:02 INFO - Running post-action listener: _resource_record_post_action 09:14:02 INFO - [mozharness: 2017-03-05 17:14:02.547731Z] Finished populate-webroot step (success) 09:14:02 INFO - [mozharness: 2017-03-05 17:14:02.547820Z] Running create-virtualenv step. 09:14:02 INFO - Running pre-action listener: _resource_record_pre_action 09:14:02 INFO - Running main action method: create_virtualenv 09:14:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:02 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 09:14:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:02 INFO - Using real prefix '/usr' 09:14:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:03 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:05 INFO - Installing pip.................done. 09:14:05 INFO - Return code: 0 09:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:14:05 INFO - Reading from file tmpfile_stdout 09:14:05 INFO - Output received: 09:14:05 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) 09:14:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:14:05 INFO - Using env: {'DISPLAY': ':0', 09:14:05 INFO - 'HOME': '/home/cltbld', 09:14:05 INFO - 'LANG': 'en_US.UTF-8', 09:14:05 INFO - 'LANGUAGE': 'en_US:en', 09:14:05 INFO - 'LOGNAME': 'cltbld', 09:14:05 INFO - 'MAIL': '/var/mail/cltbld', 09:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:05 INFO - 'MOZ_NO_REMOTE': '1', 09:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:05 INFO - 'NO_EM_RESTART': '1', 09:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:05 INFO - 'PWD': '/builds/slave/test', 09:14:05 INFO - 'SHELL': '/bin/bash', 09:14:05 INFO - 'SHLVL': '1', 09:14:05 INFO - 'TERM': 'linux', 09:14:05 INFO - 'TMOUT': '86400', 09:14:05 INFO - 'USER': 'cltbld', 09:14:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:05 INFO - '_': '/tools/buildbot/bin/python'} 09:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:05 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 09:14:05 INFO - Cleaning up... 09:14:05 INFO - Return code: 0 09:14:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:14:05 INFO - Using env: {'DISPLAY': ':0', 09:14:05 INFO - 'HOME': '/home/cltbld', 09:14:05 INFO - 'LANG': 'en_US.UTF-8', 09:14:05 INFO - 'LANGUAGE': 'en_US:en', 09:14:05 INFO - 'LOGNAME': 'cltbld', 09:14:05 INFO - 'MAIL': '/var/mail/cltbld', 09:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:05 INFO - 'MOZ_NO_REMOTE': '1', 09:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:05 INFO - 'NO_EM_RESTART': '1', 09:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:05 INFO - 'PWD': '/builds/slave/test', 09:14:05 INFO - 'SHELL': '/bin/bash', 09:14:05 INFO - 'SHLVL': '1', 09:14:05 INFO - 'TERM': 'linux', 09:14:05 INFO - 'TMOUT': '86400', 09:14:05 INFO - 'USER': 'cltbld', 09:14:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:05 INFO - '_': '/tools/buildbot/bin/python'} 09:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:05 INFO - Downloading/unpacking psutil>=3.1.1 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:07 INFO - Installing collected packages: psutil 09:14:07 INFO - Running setup.py install for psutil 09:14:07 INFO - building 'psutil._psutil_linux' extension 09:14:07 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 09:14:08 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 09:14:08 INFO - building 'psutil._psutil_posix' extension 09:14:08 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 09:14:08 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 09:14:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:08 INFO - Successfully installed psutil 09:14:08 INFO - Cleaning up... 09:14:08 INFO - Return code: 0 09:14:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:14:08 INFO - Using env: {'DISPLAY': ':0', 09:14:08 INFO - 'HOME': '/home/cltbld', 09:14:08 INFO - 'LANG': 'en_US.UTF-8', 09:14:08 INFO - 'LANGUAGE': 'en_US:en', 09:14:08 INFO - 'LOGNAME': 'cltbld', 09:14:08 INFO - 'MAIL': '/var/mail/cltbld', 09:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:08 INFO - 'MOZ_NO_REMOTE': '1', 09:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:08 INFO - 'NO_EM_RESTART': '1', 09:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:08 INFO - 'PWD': '/builds/slave/test', 09:14:08 INFO - 'SHELL': '/bin/bash', 09:14:08 INFO - 'SHLVL': '1', 09:14:08 INFO - 'TERM': 'linux', 09:14:08 INFO - 'TMOUT': '86400', 09:14:08 INFO - 'USER': 'cltbld', 09:14:08 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:08 INFO - '_': '/tools/buildbot/bin/python'} 09:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:14:10 INFO - Installing collected packages: mozsystemmonitor 09:14:10 INFO - Running setup.py install for mozsystemmonitor 09:14:10 INFO - Successfully installed mozsystemmonitor 09:14:10 INFO - Cleaning up... 09:14:10 INFO - Return code: 0 09:14:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:10 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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:10 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 09:14:10 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 09:14:10 INFO - Using env: {'DISPLAY': ':0', 09:14:10 INFO - 'HOME': '/home/cltbld', 09:14:10 INFO - 'LANG': 'en_US.UTF-8', 09:14:10 INFO - 'LANGUAGE': 'en_US:en', 09:14:10 INFO - 'LOGNAME': 'cltbld', 09:14:10 INFO - 'MAIL': '/var/mail/cltbld', 09:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:10 INFO - 'MOZ_NO_REMOTE': '1', 09:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:10 INFO - 'NO_EM_RESTART': '1', 09:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:10 INFO - 'PWD': '/builds/slave/test', 09:14:10 INFO - 'SHELL': '/bin/bash', 09:14:10 INFO - 'SHLVL': '1', 09:14:10 INFO - 'TERM': 'linux', 09:14:10 INFO - 'TMOUT': '86400', 09:14:10 INFO - 'USER': 'cltbld', 09:14:10 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:10 INFO - '_': '/tools/buildbot/bin/python'} 09:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:11 INFO - Downloading/unpacking jsonschema==2.5.1 09:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:13 INFO - warning: no files found matching '*.txt' 09:14:13 INFO - no previously-included directories found matching 'build' 09:14:13 INFO - no previously-included directories found matching 'dist' 09:14:13 INFO - no previously-included directories found matching '.git*' 09:14:13 INFO - Installing collected packages: jsonschema, functools32 09:14:13 INFO - Running setup.py install for functools32 09:14:13 INFO - warning: no files found matching '*.txt' 09:14:13 INFO - no previously-included directories found matching 'build' 09:14:13 INFO - no previously-included directories found matching 'dist' 09:14:13 INFO - no previously-included directories found matching '.git*' 09:14:13 INFO - Successfully installed jsonschema functools32 09:14:13 INFO - Cleaning up... 09:14:13 INFO - Return code: 0 09:14:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:13 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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:13 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 09:14:13 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 09:14:13 INFO - Using env: {'DISPLAY': ':0', 09:14:13 INFO - 'HOME': '/home/cltbld', 09:14:13 INFO - 'LANG': 'en_US.UTF-8', 09:14:13 INFO - 'LANGUAGE': 'en_US:en', 09:14:13 INFO - 'LOGNAME': 'cltbld', 09:14:13 INFO - 'MAIL': '/var/mail/cltbld', 09:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:13 INFO - 'MOZ_NO_REMOTE': '1', 09:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:13 INFO - 'NO_EM_RESTART': '1', 09:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:13 INFO - 'PWD': '/builds/slave/test', 09:14:13 INFO - 'SHELL': '/bin/bash', 09:14:13 INFO - 'SHLVL': '1', 09:14:13 INFO - 'TERM': 'linux', 09:14:13 INFO - 'TMOUT': '86400', 09:14:13 INFO - 'USER': 'cltbld', 09:14:13 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:13 INFO - '_': '/tools/buildbot/bin/python'} 09:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:14:13 INFO - Cleaning up... 09:14:13 INFO - Return code: 0 09:14:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:13 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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:13 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 09:14:13 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 09:14:13 INFO - Using env: {'DISPLAY': ':0', 09:14:13 INFO - 'HOME': '/home/cltbld', 09:14:13 INFO - 'LANG': 'en_US.UTF-8', 09:14:13 INFO - 'LANGUAGE': 'en_US:en', 09:14:13 INFO - 'LOGNAME': 'cltbld', 09:14:13 INFO - 'MAIL': '/var/mail/cltbld', 09:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:13 INFO - 'MOZ_NO_REMOTE': '1', 09:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:13 INFO - 'NO_EM_RESTART': '1', 09:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:13 INFO - 'PWD': '/builds/slave/test', 09:14:13 INFO - 'SHELL': '/bin/bash', 09:14:13 INFO - 'SHLVL': '1', 09:14:13 INFO - 'TERM': 'linux', 09:14:13 INFO - 'TMOUT': '86400', 09:14:13 INFO - 'USER': 'cltbld', 09:14:13 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:13 INFO - '_': '/tools/buildbot/bin/python'} 09:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:14:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 INFO - Downloading docopt-0.6.1.tar.gz 09:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:16 INFO - Running setup.py install for blobuploader 09:14:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:14:17 INFO - Running setup.py install for requests 09:14:17 INFO - Running setup.py install for docopt 09:14:17 INFO - Successfully installed blobuploader requests docopt 09:14:17 INFO - Cleaning up... 09:14:17 INFO - Return code: 0 09:14:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:17 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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:17 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 09:14:17 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 09:14:17 INFO - Using env: {'DISPLAY': ':0', 09:14:17 INFO - 'HOME': '/home/cltbld', 09:14:17 INFO - 'LANG': 'en_US.UTF-8', 09:14:17 INFO - 'LANGUAGE': 'en_US:en', 09:14:17 INFO - 'LOGNAME': 'cltbld', 09:14:17 INFO - 'MAIL': '/var/mail/cltbld', 09:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:17 INFO - 'MOZ_NO_REMOTE': '1', 09:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:17 INFO - 'NO_EM_RESTART': '1', 09:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:17 INFO - 'PWD': '/builds/slave/test', 09:14:17 INFO - 'SHELL': '/bin/bash', 09:14:17 INFO - 'SHLVL': '1', 09:14:17 INFO - 'TERM': 'linux', 09:14:17 INFO - 'TMOUT': '86400', 09:14:17 INFO - 'USER': 'cltbld', 09:14:17 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:17 INFO - '_': '/tools/buildbot/bin/python'} 09:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:17 INFO - Running setup.py (path:/tmp/pip-vWZF6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:17 INFO - Running setup.py (path:/tmp/pip-DLoGaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:17 INFO - Running setup.py (path:/tmp/pip-kFreLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:17 INFO - Running setup.py (path:/tmp/pip-cTE83P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:18 INFO - Running setup.py (path:/tmp/pip-K6Xj4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:18 INFO - Running setup.py (path:/tmp/pip-OmTHor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:18 INFO - Running setup.py (path:/tmp/pip-K7sdKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:18 INFO - Running setup.py (path:/tmp/pip-QxGje0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:18 INFO - Running setup.py (path:/tmp/pip-V2u_DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:18 INFO - Running setup.py (path:/tmp/pip-Xx1E19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:18 INFO - Running setup.py (path:/tmp/pip-fSGVQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:18 INFO - Running setup.py (path:/tmp/pip-bsbahG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:18 INFO - Running setup.py (path:/tmp/pip-LoVM1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:18 INFO - Running setup.py (path:/tmp/pip-xvIN7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:18 INFO - Running setup.py (path:/tmp/pip-RIjGBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:18 INFO - Running setup.py (path:/tmp/pip-laqqWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:18 INFO - Running setup.py (path:/tmp/pip-wuKisf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:18 INFO - Running setup.py install for manifestparser 09:14:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Running setup.py install for mozcrash 09:14:19 INFO - Running setup.py install for mozdebug 09:14:19 INFO - Running setup.py install for mozdevice 09:14:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Running setup.py install for mozfile 09:14:19 INFO - Running setup.py install for mozhttpd 09:14:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Running setup.py install for mozinfo 09:14:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Running setup.py install for mozInstall 09:14:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:19 INFO - Running setup.py install for mozleak 09:14:19 INFO - Running setup.py install for mozlog 09:14:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:20 INFO - Running setup.py install for moznetwork 09:14:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:20 INFO - Running setup.py install for mozprocess 09:14:20 INFO - Running setup.py install for mozprofile 09:14:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:20 INFO - Running setup.py install for mozrunner 09:14:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:20 INFO - Running setup.py install for mozscreenshot 09:14:20 INFO - Running setup.py install for moztest 09:14:20 INFO - Running setup.py install for mozversion 09:14:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:20 INFO - Cleaning up... 09:14:20 INFO - Return code: 0 09:14:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:20 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')]} 09:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:20 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')]} 09:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:20 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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:20 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 09:14:20 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 09:14:20 INFO - Using env: {'DISPLAY': ':0', 09:14:20 INFO - 'HOME': '/home/cltbld', 09:14:20 INFO - 'LANG': 'en_US.UTF-8', 09:14:20 INFO - 'LANGUAGE': 'en_US:en', 09:14:20 INFO - 'LOGNAME': 'cltbld', 09:14:20 INFO - 'MAIL': '/var/mail/cltbld', 09:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:20 INFO - 'MOZ_NO_REMOTE': '1', 09:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:20 INFO - 'NO_EM_RESTART': '1', 09:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:20 INFO - 'PWD': '/builds/slave/test', 09:14:20 INFO - 'SHELL': '/bin/bash', 09:14:20 INFO - 'SHLVL': '1', 09:14:20 INFO - 'TERM': 'linux', 09:14:20 INFO - 'TMOUT': '86400', 09:14:20 INFO - 'USER': 'cltbld', 09:14:20 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:20 INFO - '_': '/tools/buildbot/bin/python'} 09:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:20 INFO - Running setup.py (path:/tmp/pip-aIsDWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:21 INFO - Running setup.py (path:/tmp/pip-aWiyPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:21 INFO - Running setup.py (path:/tmp/pip-42TLKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:21 INFO - Running setup.py (path:/tmp/pip-8TP0a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:21 INFO - Running setup.py (path:/tmp/pip-RipAeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:21 INFO - Running setup.py (path:/tmp/pip-CLcq50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:21 INFO - Running setup.py (path:/tmp/pip-AiYS0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:21 INFO - Running setup.py (path:/tmp/pip-zW1JdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:21 INFO - Running setup.py (path:/tmp/pip-Nhxjq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:21 INFO - Running setup.py (path:/tmp/pip-leJX5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:21 INFO - Running setup.py (path:/tmp/pip-K2ni6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:21 INFO - Running setup.py (path:/tmp/pip-YoPCgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:21 INFO - Running setup.py (path:/tmp/pip-TU_DVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:21 INFO - Running setup.py (path:/tmp/pip-TtiXkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:21 INFO - Running setup.py (path:/tmp/pip-U6JcEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:22 INFO - Running setup.py (path:/tmp/pip-SZ80OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:22 INFO - Running setup.py (path:/tmp/pip-HABPnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:22 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 09:14:22 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 09:14:22 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 09:14:22 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 09:14:22 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 09:14:22 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 09:14:24 INFO - Downloading blessings-1.6.tar.gz 09:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:24 INFO - Installing collected packages: blessings 09:14:24 INFO - Running setup.py install for blessings 09:14:24 INFO - Successfully installed blessings 09:14:24 INFO - Cleaning up... 09:14:24 INFO - Return code: 0 09:14:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:24 INFO - Reading from file tmpfile_stdout 09:14:24 INFO - Current package versions: 09:14:24 INFO - argparse == 1.2.1 09:14:24 INFO - blessings == 1.6 09:14:24 INFO - blobuploader == 1.2.4 09:14:24 INFO - docopt == 0.6.1 09:14:24 INFO - functools32 == 3.2.3-2 09:14:24 INFO - jsonschema == 2.5.1 09:14:24 INFO - manifestparser == 1.1 09:14:24 INFO - mozInstall == 1.12 09:14:24 INFO - mozcrash == 1.0 09:14:24 INFO - mozdebug == 0.1 09:14:24 INFO - mozdevice == 0.49 09:14:24 INFO - mozfile == 1.2 09:14:24 INFO - mozhttpd == 0.7 09:14:24 INFO - mozinfo == 0.9 09:14:24 INFO - mozleak == 0.1 09:14:24 INFO - mozlog == 3.4 09:14:24 INFO - moznetwork == 0.27 09:14:24 INFO - mozprocess == 0.24 09:14:24 INFO - mozprofile == 0.28 09:14:24 INFO - mozrunner == 6.13 09:14:24 INFO - mozscreenshot == 0.1 09:14:24 INFO - mozsystemmonitor == 0.3 09:14:24 INFO - moztest == 0.8 09:14:24 INFO - mozversion == 1.4 09:14:24 INFO - psutil == 3.1.1 09:14:24 INFO - requests == 1.2.3 09:14:24 INFO - wsgiref == 0.1.2 09:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:24 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')]} 09:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:24 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')]} 09:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:24 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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:24 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 09:14:24 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 09:14:24 INFO - Using env: {'DISPLAY': ':0', 09:14:24 INFO - 'HOME': '/home/cltbld', 09:14:24 INFO - 'LANG': 'en_US.UTF-8', 09:14:24 INFO - 'LANGUAGE': 'en_US:en', 09:14:24 INFO - 'LOGNAME': 'cltbld', 09:14:24 INFO - 'MAIL': '/var/mail/cltbld', 09:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:24 INFO - 'MOZ_NO_REMOTE': '1', 09:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:24 INFO - 'NO_EM_RESTART': '1', 09:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:24 INFO - 'PWD': '/builds/slave/test', 09:14:24 INFO - 'SHELL': '/bin/bash', 09:14:24 INFO - 'SHLVL': '1', 09:14:24 INFO - 'TERM': 'linux', 09:14:24 INFO - 'TMOUT': '86400', 09:14:24 INFO - 'USER': 'cltbld', 09:14:24 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:24 INFO - '_': '/tools/buildbot/bin/python'} 09:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 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)) 09:14:24 INFO - Cleaning up... 09:14:24 INFO - Return code: 0 09:14:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:24 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')]} 09:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:24 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')]} 09:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:24 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 0x28741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2984a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', '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 09:14:24 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 09:14:24 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 09:14:24 INFO - Using env: {'DISPLAY': ':0', 09:14:24 INFO - 'HOME': '/home/cltbld', 09:14:24 INFO - 'LANG': 'en_US.UTF-8', 09:14:24 INFO - 'LANGUAGE': 'en_US:en', 09:14:24 INFO - 'LOGNAME': 'cltbld', 09:14:24 INFO - 'MAIL': '/var/mail/cltbld', 09:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:24 INFO - 'MOZ_NO_REMOTE': '1', 09:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:24 INFO - 'NO_EM_RESTART': '1', 09:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:24 INFO - 'PWD': '/builds/slave/test', 09:14:24 INFO - 'SHELL': '/bin/bash', 09:14:24 INFO - 'SHLVL': '1', 09:14:24 INFO - 'TERM': 'linux', 09:14:24 INFO - 'TMOUT': '86400', 09:14:24 INFO - 'USER': 'cltbld', 09:14:24 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:24 INFO - '_': '/tools/buildbot/bin/python'} 09:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:25 INFO - Cleaning up... 09:14:25 INFO - Return code: 0 09:14:25 INFO - Running post-action listener: _resource_record_post_action 09:14:25 INFO - Running post-action listener: _start_resource_monitoring 09:14:25 INFO - Starting resource monitoring. 09:14:25 INFO - [mozharness: 2017-03-05 17:14:25.187024Z] Finished create-virtualenv step (success) 09:14:25 INFO - [mozharness: 2017-03-05 17:14:25.187475Z] Running install step. 09:14:25 INFO - Running pre-action listener: _resource_record_pre_action 09:14:25 INFO - Running main action method: install 09:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:25 INFO - Reading from file tmpfile_stdout 09:14:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:25 INFO - Reading from file tmpfile_stdout 09:14:25 INFO - Output received: 09:14:25 INFO - Usage: mozinstall [options] installer 09:14:25 INFO - Options: 09:14:25 INFO - -h, --help show this help message and exit 09:14:25 INFO - -d DEST, --destination=DEST 09:14:25 INFO - Directory to install application into. [default: 09:14:25 INFO - "/builds/slave/test"] 09:14:25 INFO - --app=APP Application being installed. [default: firefox] 09:14:25 INFO - mkdir: /builds/slave/test/build/application 09:14:25 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'] 09:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:14:42 INFO - Reading from file tmpfile_stdout 09:14:42 INFO - Output received: 09:14:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:14:42 INFO - Running post-action listener: _resource_record_post_action 09:14:42 INFO - [mozharness: 2017-03-05 17:14:42.201064Z] Finished install step (success) 09:14:42 INFO - [mozharness: 2017-03-05 17:14:42.201405Z] Running run-tests step. 09:14:42 INFO - Running pre-action listener: _resource_record_pre_action 09:14:42 INFO - Running main action method: run_tests 09:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:42 INFO - Python 2.7.3 09:14:42 INFO - Return code: 0 09:14:42 INFO - grabbing minidump binary from tooltool 09:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:42 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 0x2c6f850>, '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 0x2be46d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:42 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 09:14:42 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 09:14:42 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 09:14:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:42 INFO - Return code: 0 09:14:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:14:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:14:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 09:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 09:14:42 INFO - Using env: {'DISPLAY': ':0', 09:14:42 INFO - 'HOME': '/home/cltbld', 09:14:42 INFO - 'LANG': 'en_US.UTF-8', 09:14:42 INFO - 'LANGUAGE': 'en_US:en', 09:14:42 INFO - 'LOGNAME': 'cltbld', 09:14:42 INFO - 'MAIL': '/var/mail/cltbld', 09:14:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:42 INFO - 'MOZ_NO_REMOTE': '1', 09:14:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:42 INFO - 'NO_EM_RESTART': '1', 09:14:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:42 INFO - 'PWD': '/builds/slave/test', 09:14:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:42 INFO - 'SHELL': '/bin/bash', 09:14:42 INFO - 'SHLVL': '1', 09:14:42 INFO - 'TERM': 'linux', 09:14:42 INFO - 'TMOUT': '86400', 09:14:42 INFO - 'USER': 'cltbld', 09:14:42 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437', 09:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:42 INFO - '_': '/tools/buildbot/bin/python'} 09:14:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 09:14:42 INFO - mozversion application_buildid: 20170305162304 09:14:42 INFO - mozversion application_changeset: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 09:14:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:14:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:42 INFO - mozversion application_name: Firefox 09:14:42 INFO - mozversion application_remotingname: firefox-dev 09:14:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:14:42 INFO - mozversion application_vendor: Mozilla 09:14:42 INFO - mozversion application_version: 53.0a2 09:14:42 INFO - mozversion platform_buildid: 20170305162304 09:14:42 INFO - mozversion platform_changeset: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 09:14:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:14:42 INFO - mozversion platform_version: 53.0a2 09:14:42 INFO - using testdate: 1488734082 09:14:42 INFO - actual date: 1488734082 09:14:42 INFO - starting webserver on 'localhost:55802' 09:14:42 INFO - SUITE-START | Running 2 tests 09:14:42 INFO - TEST-START | dromaeo_css 09:14:42 INFO - operating with platform_type : linux_ 09:14:42 INFO - Initialising browser for dromaeo_css test... 09:14:42 INFO - TEST-INFO | started process 12920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgNgb8M/profile http://localhost:55802/getInfo.html) 09:14:46 INFO - PROCESS | 12920 | __metrics Screen width/height:1600/1200 09:14:46 INFO - PROCESS | 12920 | colorDepth:24 09:14:46 INFO - PROCESS | 12920 | Browser inner width/height: 1024/697 09:14:46 INFO - PROCESS | 12920 | __metrics 09:14:47 INFO - PROCESS | 12920 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:14:47 INFO - PROCESS | 12920 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:48 INFO - TEST-INFO | 12920: exit 0 09:14:48 INFO - Browser initialized. 09:14:48 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:48 INFO - TEST-INFO | started process 13013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgNgb8M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:00 INFO - PROCESS | 13013 | RSS: Main: 138354688 09:15:00 INFO - PROCESS | 13013 | 09:18:00 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55802/tests/dromaeo/cssquery-ext.html) 09:18:01 INFO - PROCESS | 13013 | RSS: Main: 243064832 09:18:01 INFO - PROCESS | 13013 | 09:19:50 INFO - PROCESS | 13013 | ************************* 09:19:50 INFO - PROCESS | 13013 | A coding exception was thrown and uncaught in a Task. 09:19:50 INFO - PROCESS | 13013 | 09:19:50 ERROR - PROCESS | 13013 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:19:50 INFO - PROCESS | 13013 | Full stack: 09:19:50 INFO - PROCESS | 13013 | ************************* 09:21:04 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-ext.html (next: http://localhost:55802/tests/dromaeo/cssquery-jquery.html) 09:21:04 INFO - PROCESS | 13013 | RSS: Main: 222613504 09:21:04 INFO - PROCESS | 13013 | 09:24:06 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55802/tests/dromaeo/cssquery-mootools.html) 09:24:07 INFO - PROCESS | 13013 | RSS: Main: 217042944 09:24:07 INFO - PROCESS | 13013 | 09:27:09 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55802/tests/dromaeo/cssquery-prototype.html) 09:27:09 INFO - PROCESS | 13013 | RSS: Main: 202948608 09:27:09 INFO - PROCESS | 13013 | 09:30:12 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55802/tests/dromaeo/cssquery-yui.html) 09:30:13 INFO - PROCESS | 13013 | RSS: Main: 169373696 09:30:13 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-yui.html (next: http://localhost:55802/tests/dromaeo/cssquery-dojo.html) 09:33:15 INFO - PROCESS | 13013 | RSS: Main: 258244608 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | __start_tp_report 09:33:15 INFO - PROCESS | 13013 | _x_x_mozilla_page_load 09:33:15 INFO - PROCESS | 13013 | _x_x_mozilla_page_load_details 09:33:15 INFO - PROCESS | 13013 | |i|pagename|runs| 09:33:15 INFO - PROCESS | 13013 | |0;dojo.html;3299.406106900757;3308.5533452983846;3321.701046905778;3351.9162020949475;3354;5443.319585051869;5493.1760235964575;5501.092319767234;5509.6969666668265;5516.282883225185;5419.5393391561765;5477.863053423666;5496.835094947158;5514.228008078872;5525.889482210353;5013.172826483626;5033.874153146164;5067.49325067494;5110.412302585194;5125.692458452505;5004.449510553836;5070.112730272188;5127.333446651949;5129.769160387773;5131.7690703918415;4945.7032578045255;4963;4964.0816448956875;4968.6025117990475;5019.472955339692;5006.3241462402475;5076.568491678193;5086.3133476980875;5087.56755675768;5113.872153196163;4931.457539670633;4959;5053.772580233898;5062.417821950486;5065.037642847848;5369.489898459679;5374.6506477078865;5410.594205434608;5416.458354164592;5429.511343979061;5849.678267695275;5884.911726324109;5896.734646940898;5899.970500147472;5930.199423077873;5933.495652869511;5940.079287710412;5941.613795103348;5948.167256584082;5948.40515948406;5325.121354976463;5353.822159125025;5426.620136590401;5461.2627295315415;5542.140968149944;5969.611975221596;5970.373110823388;5971.880562388728;6007.249093863267;6008.579399441997;5749.942500574941;5755.65466072037;5756.280464941882;5762.078067509262;5766.625169363978;5678.943210567924;5694.715264236855;5794.333651630117;5862.120681897664;5863.355030946593;5866;5886.529077673776;5935.2877654681715;5965.13505541694;5974.163617093611;5938.346781853993;5947.672877991666;5948.434898684618;5948.7323070461935;5953.255843019622;4453.309736990772;4503.909921801545;4555.840545580889;4570.337301091323;4578.702384345007;4023.4970628671417;4047.0894048838777;4051.6758659307775;4070.674346052309;4099.036726369361;5711.3146422428745;5723.971380143073;5724.169995350734;5726.828195154152;5745.080787074048;5752.194692743019;5772.249607550992;5822.563307751935;5914.319853216935;5914.822555323347;5629.043062679354;5655.462731040545;5655.717214139277;5688.203651488795;5697.829065127969;4975.626827987915;4979.128652485801;4991.9500804991485;4994.200927851526;5027.673201241908;5958.255218097738;6024.698765061729;6054.091886217103;6067.54493412987;6085.208922840003;5859.2090067842;5909.3795151508475;5911.05423132314;5994.880102398015;6034.939650603438;6169.183052726672;6198.349173336735;6203.844903877439;6204.348543402878;6207.224096987877;5661.235733176133;5836.387179346108;5886.529077673861;5890.087036509348;5918.7928422505;5783.971080144573;5840.707964601838;5867.970660146672;5879.588428809942;5966.134910438049;5716.5998380113;5793.8551536211935;5803.448672376117;5805.158252053344;5808.332041815245;5720.08478643415;5766;5767.250257466502;5772.336181339199;5774.133879918046;5603.0474819281635;5612.579056570855;5719.428057194414;5724.141378793214;5732.57005724564;5819.5344372450945;5836.299644042742;5839.474447299764;5855.560832937632;5857;5714.657120572779;5717.771289148387;5731.455511726379;5736.8278951629845;5737.885242295048 09:33:15 INFO - PROCESS | 13013 | |1;ext.html;535.3559933700338;578.4562511239435;603.1887111834583;612.8529153003278;630.010882913825;36420;46901;47946.041079178394;47986.280205796895;48153.277700834515;50532.242016369695;50989.490105098936;51117.48882511174;51124.74437627816;51212;8759.693410730626;8992.460452372847;9441.575129119206;9645.758856028586;9648.903510964907;11060.281081729701;11346.149038822081;11349.943250283737;11766.588169414072;11776.175667703264;11588.942055289712;11672.941635291812;11675.299482031105;11675.474603642813;11682.12384071198;11398.601048963288;11399.943000285028;11453.541858325658;11462.140339474572;11464.71338216543;11282.097432205486;11356.375399353032;11371.829422558669;11374.71563210918;11385.715357116056;46771;47254;47262.29106563405;47307;47321.29018064732;4417.271150260203;4486.753228572427;4519.593236608721;4581.266997280419;4714.363560919266;32362.83818580892;32471.863484777918;32719.018429447155;32737;33574.6642533574;4654.767261636938;4666.883327916796;4698.8355407560575;4730.668853180278;4790.712557246541;357076;358489;358880;359110;359242;60135.097973530435;60310;60458.39541604616;60481.69759151176;60585.99999999912;63127;63149;63205;63328.36671633317;63336.36663633305;19120.2351905925;19402;19418.417447476597;19439.514012149528;19453.610927781367;13563.118397304144;13594.864051359558;13936.790948135786;15223.467178648694;15329.923350383177;18783.90608046951;19671.409857704293;19755.40733777989;19760.802391975896;19880;7083.610401427971;7182.856342873113;7329.8010596821805;7490.363319117827;7527.849443011219;990.1435258501344;998.6554638649654;1007.4559737741685;1012.0840639221516;1015.5176291261591;34279.65720342815;34315.313693725984;34316.65683343135;34369.82815085958;35057.298854023284;1162.7906976744268;1166.6150170443734;1186.4423720851187;1190.434543591787;1258.4903114238748;17798.783797917094;18065.2773889043;18151.183196756177;18218.544536386697;18326;164558;164924;165281.17359413125;165660;166084;70276.297237028;70511;71038.64480677668;71112.2888771116;71247.2875271251;1514.8182218133895;1526.1606116635805;1546.420092465303;1562.6015366081576;1563.241827713558;32049;33155.00534983954;33430.665693343726;33478.16304592405;33634.327313453105;58945;59472;59573;59716;59771;422644;424579;424708;425656;426508;28599.571006434504;31793.682063179072;36995.26009479741;37576.81211594034;39693.2061358777;42863;43377.783111084245;47511;47730;47987.520124798306;39769.60230397659;39937;40868.38697419601;41385.37921931113;41422;38969.80515097406;38998.80500597479;39462.40806387849;40537;40753.38869917013;39487.60512394839;39712.2057558853;39947.60052399439;41339.586604133576;41392.37911431391;34256.82871585626;36262;37041.814790926954;37214.63577578651;37687.434688479145;27748.583771243044;27951.72048279491;27978.440431190855;28049.29876753016;28242.85878570594 09:33:15 INFO - PROCESS | 13013 | |2;jquery.html;427.37176350764366;432.71008424355676;434.63558243157223;440.15490258703295;444.8265176581132;20024.89987550062;20773.480662983413;22055.889720551415;22214.333569992887;22339.329820105402;21893;23205.303840884757;23263.534729305404;23299.068037278532;23518.64722029171;6083.20918280624;6096.390360963913;6310.242770867502;6314.02132669437;6316.30520642729;6009.429104235091;6122.234720659918;6159.8768024639485;6171.7222724977255;6172.783952561661;5918.674472903988;6112.297085835119;6119.663418512002;6122.877542449149;6127.172831667713;6095.7561697532265;6138.84652883677;6143.815685529419;6144.170536977495;6146.446819786218;5448.346198456171;5493;5523;5527.309086364205;5538.224648549206;25771.226863194133;26271.605925911128;26325.73674263252;26327.605085923726;26431.867840660867;3284.83575821208;3391.1183092396154;3442.707369873564;3468.4277094279414;3484.0244731475227;11012.119030477543;11160.944195279053;15265.771013434807;15866.761998570031;16584.50246492607;1996.8302694271003;2026.695995600657;2040.6020825938947;2042.4485388944902;2050.76416212136;90013;92200;92329;92355.53822230913;93051;12231.204971676812;12422.565210217599;12566.560170393992;12597.87402125967;12793.872061279455;18196.818031819777;18291.262330078887;18380.816191838177;18385.90807045983;18399.90800046018;9448.905510944802;9499.530122168147;9564.378315409476;9634.277429192838;9635.614575416905;9135.269178465707;9195.586198621078;9216.493092879957;9231.953840230755;9434.103760142776;5444.40111587725;5448.918266225931;5489.1217405214975;5490.670559766427;5577.553795696334;2190.539986602799;2200.1969281212564;2253.3465295064248;2260.011190152655;2283.7259528856644;920.6133423961952;929.9349045566745;937.8593211018265;946.9431834089977;956.086936975187;19865.106070226873;21383.46541336479;21603.140181721817;21632.675509867364;21712.394512658266;955.441066975827;962.5716556132454;966.9226461883032;983.331334692416;985.8028394321165;11591.84081591851;11778.587749428729;11812.645620631394;11896;11940.820887686517;517290;742689;753139;765899;786120;99148.5042574797;100750.99999999853;109679.45160274148;113675.43162284135;114937.4253128729;1145.238416453066;1166.4401087477888;1192.3382522699812;1193.498730533178;1195.6114262864603;19195.424137275902;19483.61032779365;19517.70723439121;19599.31402400909;19709.40871773849;36767.264654707295;39514.2097158061;46134.30798538092;47305.7634711838;48366.27450588174;68147.65926170337;68214;69557;69570;69980.65009674919;8999.64001439935;9063.320250981335;9127;9225.953870230605;9372.39079459833;13890.374933127832;14485.130892146504;14519.637009074857;14839.10965342083;15082;11455.312681239153;11889.643310700692;11941.402929853646;12006.399680016139;12132.818007730068;11680.240784348991;11710.180287379802;11996.340201289013;12262.4481898313;12842.486300547873;11955;12409.875901240872;12536.811947820972;12647.747045058863;12759.234445933274;9098.863517047117;9218.585163667785;9308.860367094634;9350.812983740423;9382.343235973416;11719.414029298672;12004.039676826007;12241.510339586674;12667.746645066863;13023.739525209632 09:33:15 INFO - PROCESS | 13013 | |3;mootools.html;1403.319390095804;1479.7188534178506;1491.4779827060527;1510.192047254719;1512.2589930933843;7475.887861682072;8070.798230044252;8427.494350338984;8428.452150610206;8632.611532481038;8480.872786908201;8509.489430634167;8530.019047809505;8558.743237702864;8564.614592343343;2080.355089922129;2151.343840128768;2355.422921384263;2394.928152155438;2395.053953688292;2347.4366152123453;2421.5278020785954;2424.1636635360774;2432.6472661464077;2443.1082654831034;2223.3552269841725;2248.87631180285;2258.0177622734163;2258.627326491135;2258.977410225901;2345.3901985483812;2350.2949115265524;2357.446000189954;2364.1843563970488;2364.9763502364926;2210.9005094770614;2360.173939121311;2362.61016932206;2365.1958334166466;2366.3019409274307;8446.113158118433;8475.830483390298;8487.066422693499;8493.83012339756;8505.192006759347;5098.719570423626;5219.19102539107;5220.3735551734035;5221.947780522184;5232.398274198478;3056.9847150764326;3241.6434192238835;3243.4486137356707;3266.4283750343834;3283.1627934876456;1397.6715471864104;1476.75633520469;2135.8291336693183;2140.1332460353583;2150.5268840854988;11392.259503132353;11393.145514086476;11444.370559619301;11462.083033357312;11464.828027579593;4266.210751011073;4505.684602077823;4510.413646225969;4590.059037897223;4606.723596584216;9348.719538413858;9403;9409.48247846375;9417.434953902788;9429.90570094304;5270.868228294324;5277.287566178594;5277.8416647500635;5278.366596008504;5278.709670968134;4819.95180048202;4828.5412885775795;4860.659753817199;4923.040007198562;4924.8768780780765;3797.1266608680157;3894.3184942634925;3897.649211570972;3928.744631598937;3972.1857019310974;1187.5962172861268;1196.491491116272;1203.4404002138872;1212.115155936154;1218.226426219357;957.3872721458272;987.6247026130025;989.2382865193761;992.8262554053011;1006.8288390973552;5707.258056452718;5732.77068917247;5847.444492773265;5932.911006334908;5967.850803729854;990.7126933189294;1018.9133923616428;1057.8095942730383;1060.4782137632521;1110.5002748763088;3870.825812838429;3923.862664806718;3924.6664033557468;4038.2327357801923;4081.2041651878194;10096.545655445523;10277.383356998604;10393.16854651626;10399.116075133546;10410.68767936963;10080.798384032278;10234.846477302846;10264.743381415525;10271;10279;8010.679572817022;8024.117347091932;8116.391270654606;8141.063777665526;8164.67341306353;5396.244525766474;5411.377691565521;5436;5465.262189604353;5583.385827558884;9470.337076404585;9475.099865512766;9484.668036618685;9491;9561.665341713007;8604.741857744277;9080.182783549248;9351.298652600946;9383.34316597859;9628.133467987915;6827.658617069027;7317.670704818403;7403.925960740539;7508;7665.885011724717;8222.671093156207;8266.090730019572;8282.875756863772;8322.750317490485;8347.874781878398;7498.437617178624;7555.16893141743;7561.357284630868;7619.1999840016;7760.573168475788;7246.673899674633;7431.665575049244;7441.404687625085;7444.590547519939;7479.775606731807;6645.933540664531;6708.83227919306;6778.254392016973;6780.38976492118;6786.694598743167;4917.139500587455;4933.58064564516;4940.530649588283;4976;5015.04714104319;4941.75291235444;4949.1586430306215;5114.539691427789;5125.513076257749;5174.353205849269 09:33:15 INFO - PROCESS | 13013 | |4;prototype.html;370.0766587364526;371.5893937199396;371.8438255932508;378.9791561464119;381.89497888080774;5363.570914326854;5372.194170874371;5381.838544843651;5390.137577987513;5418.106012507931;5085.61857860661;5143.7912090658665;5214.71472972028;5252.737363131838;5317.415084340729;4240.936385954213;4243.363495475673;4266.885173823111;4277.379779931915;4285.121550082241;4273.978630106845;4276.97861510692;4277.165952639237;4289.227938970984;4304.634106100985;4023.3160362738404;4102.528209255944;4272.252355837732;4272.807723652443;4276.465441819772;4232.428622136018;4268.658507319407;4269.615734583902;4298.613124818781;4314.892127696801;3886.125621735115;3895.4935858338517;3898;3901.5708272090046;3923.862664806718;5079.6698214615935;5149.922751158736;5151.5106064923775;5207.515857980496;5210.374755029383;4881.8535443936735;4897.706137631718;4923.286123512106;4923.384576927884;4933.753312334405;5553.16702494625;5573.27547418833;5574.414686457944;5603.2435621191025;5610.663360198401;3797.259534390795;3989.7207195496326;4051.3315302974975;4306.5478124796755;4307.440032795748;5674.829755107395;5765.827025189251;5766.4430603736755;5790.478856902857;5801.854953626151;4069.552349241581;4075.449814275094;4083.9795801020805;4087.4277601135864;4095.3242714952294;4165.58344165581;4192.958070419318;4195.454590903163;4245.341971994346;4414.55854414556;4890.902181956341;4899.191633380524;4916.582090522345;4935.703857768545;4961.875953101201;5632.774689012475;5633.492985631313;5634.971825140848;5640.492355688008;5669.546436285087;1464.1727424005403;1485.6508720450686;1492.79847220626;1498.2658497336226;1502.4140585171792;1014.8122597319519;1030.1912998296302;1050.485262221506;1084.219362059316;1084.6854412220525;5395.217693434509;5410.567154627621;5415.377231618336;5423.566114710814;5447.428020057916;5578.079616863172;5642.379338272786;5642.915356269659;5653.802116925888;5674.4892959633835;5125.282460455539;5289.3917199521775;5335.306410166731;5362.9084656983805;5374.5700343972385;2955.940881182364;2957.2459022949442;2960.5411161270035;2982.7166419190144;2988.8194163305375;5650.039493286151;5690.3013041523345;5814.098814683731;5819.53443724501;5978.970105149533;5860.011394188909;5883.940890639726;5885.176075349455;5921.082232254007;5927.436893495111;5960.331107289966;5969.134475501028;5986.191864098291;6023.939760602338;6036.004059330161;5556.499915007668;5727.599068065362;5734;5744.167095771007;5761.5390768739235;5634.718264086698;5697.515711164431;5699.373068962328;5702.486776190163;5757.481826635623;5709.51469125129;5890.381509941394;5948.494377977747;5998.1105951625095;6017;4121.793910304533;4132.876013719593;4148.522919864255;4156.418101465858;4163.646090082377;5785.450382213683;5792.304923409218;5793.681347525927;5804.332501762351;5806.738696758572;5347.759350829144;5631.493165615114;5640.774369025193;5663.801766938137;5668.546516278605;5629.183768353648;5640.869317528811;5644.717764111861;5645.616823878177;5649.152627105803;5401.567874569946;5410;5528.778848846001;5595.244641973444;5645.604807663424;5555.250041244381;5556.861078472909;5565.499105080562;5572.972135139298;5573.498385145356;5484.177373394023;5494.642848214853;5526.3420973706925;5535.308086489189;5570.991664501124 09:33:15 INFO - PROCESS | 13013 | |5;yui.html;816.9509829410235;836.9414141010132;853.3301358433631;919.3702313914969;940.4780346907465;15775.290111944962;17331.046792426412;17684.646307073883;17925.641487170247;17991.19039643216;15458.458953936586;15561.53315400537;15687.137207453585;15699.37202511898;15835.762463563056;837.1879277101202;849.617672047578;851.4678326046221;852.2755657690975;852.4033176776251;718.6801873166443;736.8968344431784;820.2945466898492;836.9748907532753;844.2106630300658;891.6611687558751;892.9508877011762;896.4352457951481;897.5377680494518;898.0884402331639;886.4814083761007;888.0320450708726;888.4358432395411;889.0664801957982;889.1997202517754;544.1484077418827;556.1629747230432;627.078195053271;635.8569321902581;643.7296335539038;17102.82897171025;17614.383496577557;17637.02996335201;17654.20556074967;17668.734968975477;14748.778768318483;15450.304736286895;15557;15586.298616562282;15719;13473.932630336785;13521.864781352257;13533.458661653522;13551.796723049161;13662.658433539142;3892.7469714468752;4490.438695163105;4545.2273113570445;4594.104149690812;4670.229412146991;83889.58055209745;84285.57857210675;84975;85158.57420712856;86124.56937715334;12426.937865310796;12447.626571202878;12453.688657783629;12519.749605007848;12724.300163491096;23129.421764456023;23210;23321.416964576023;23403.297901062997;23577.406485286603;8373.706920257884;8516.361272904556;8549.059603443617;8654.82690346202;8818.29453643707;4791.137595232892;4847.224444088999;4950.925736113961;4960.925586116211;5031.245313202976;3959.9406008909314;4069.5320038195987;4070.5725898780793;4077;4078.46979892618;618.2704408797572;618.7617767159586;620.5687047502033;620.7796232337546;631.5137344244906;858.0689951402798;863.4171933944563;867.492516877621;869.6521391443473;894.8881389826272;10934.890651093547;10995.615153469591;11309.547618095348;11820.172587918763;12064.276143431247;826.7891687619739;827.4828232354778;830.667732906842;833.3874602167402;839.1608391608391;5291.629585929025;5298.178782288752;5306.293371620048;5361.437049109865;5372.516473517324;82121.58939205266;82179;82210;82988.58505707434;83958;57083;58927.410725892194;66686;74401.25598744051;74906.25093748992;59030.70484647635;59775;60740.99999999912;67423;68418.65790671014;10673.306235094695;10947.507362168562;11080.224384293344;11246.943765281121;11249.831252531056;40735.38896916608;41215;41241.1751764969;42380.788096059325;42458.36312455254;52673;52787;56167.436097288526;57264;59609.40390596212;13199.868001319865;13241.801372979606;13254.867451325363;13585.45658173662;13681.521146759816;14255.64360890986;14661.85338146605;15055.77416338734;15075.24623768829;15628.218589070273;14766.852331476977;14899.404023838924;15152.912705615077;15428.151451670266;15503.612409689847;14455.85544144545;15260.313285902383;15730;15857;16381.508554743377;14446.061524352659;14952.476663316731;15574.299156538209;15641.374345026526;15679.216039198223;12411.751764964469;12879.549215777777;12901.483940642269;13044.804327935279;13119.475220991053;11701.941490292495;11983.940080299542;12860.614181574567;13014.674633134247;13189.538366157138 09:33:15 INFO - PROCESS | 13013 | __end_tp_report 09:33:15 INFO - PROCESS | 13013 | __start_cc_report 09:33:15 INFO - PROCESS | 13013 | _x_x_mozilla_cycle_collect,941 09:33:15 INFO - PROCESS | 13013 | __end_cc_report 09:33:15 INFO - PROCESS | 13013 | __startTimestamp1488735195719__endTimestamp 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | ------- Summary: start ------- 09:33:15 INFO - PROCESS | 13013 | Number of tests: 6 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | [#0] dojo.html Cycles:165 Average:5486.94 Median:5724.14 stddev:604.36 (10.6%) stddev-sans-first:581.34 09:33:15 INFO - PROCESS | 13013 | Values: 3299.4 3308.6 3321.7 3351.9 3354.0 5443.3 5493.2 5501.1 5509.7 5516.3 5419.5 5477.9 5496.8 5514.2 5525.9 5013.2 5033.9 5067.5 5110.4 5125.7 5004.4 5070.1 5127.3 5129.8 5131.8 4945.7 4963.0 4964.1 4968.6 5019.5 5006.3 5076.6 5086.3 5087.6 5113.9 4931.5 4959.0 5053.8 5062.4 5065.0 5369.5 5374.7 5410.6 5416.5 5429.5 5849.7 5884.9 5896.7 5900.0 5930.2 5933.5 5940.1 5941.6 5948.2 5948.4 5325.1 5353.8 5426.6 5461.3 5542.1 5969.6 5970.4 5971.9 6007.2 6008.6 5749.9 5755.7 5756.3 5762.1 5766.6 5678.9 5694.7 5794.3 5862.1 5863.4 5866.0 5886.5 5935.3 5965.1 5974.2 5938.3 5947.7 5948.4 5948.7 5953.3 4453.3 4503.9 4555.8 4570.3 4578.7 4023.5 4047.1 4051.7 4070.7 4099.0 5711.3 5724.0 5724.2 5726.8 5745.1 5752.2 5772.2 5822.6 5914.3 5914.8 5629.0 5655.5 5655.7 5688.2 5697.8 4975.6 4979.1 4992.0 4994.2 5027.7 5958.3 6024.7 6054.1 6067.5 6085.2 5859.2 5909.4 5911.1 5994.9 6034.9 6169.2 6198.3 6203.8 6204.3 6207.2 5661.2 5836.4 5886.5 5890.1 5918.8 5784.0 5840.7 5868.0 5879.6 5966.1 5716.6 5793.9 5803.4 5805.2 5808.3 5720.1 5766.0 5767.3 5772.3 5774.1 5603.0 5612.6 5719.4 5724.1 5732.6 5819.5 5836.3 5839.5 5855.6 5857.0 5714.7 5717.8 5731.5 5736.8 5737.9 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | [#1] ext.html Cycles:180 Average:51674.64 Median:37395.72 stddev:88288.10 (236.1%) stddev-sans-first:88452.27 09:33:15 INFO - PROCESS | 13013 | Values: 535.4 578.5 603.2 612.9 630.0 36420.0 46901.0 47946.0 47986.3 48153.3 50532.2 50989.5 51117.5 51124.7 51212.0 8759.7 8992.5 9441.6 9645.8 9648.9 11060.3 11346.1 11349.9 11766.6 11776.2 11588.9 11672.9 11675.3 11675.5 11682.1 11398.6 11399.9 11453.5 11462.1 11464.7 11282.1 11356.4 11371.8 11374.7 11385.7 46771.0 47254.0 47262.3 47307.0 47321.3 4417.3 4486.8 4519.6 4581.3 4714.4 32362.8 32471.9 32719.0 32737.0 33574.7 4654.8 4666.9 4698.8 4730.7 4790.7 357076.0 358489.0 358880.0 359110.0 359242.0 60135.1 60310.0 60458.4 60481.7 60586.0 63127.0 63149.0 63205.0 63328.4 63336.4 19120.2 19402.0 19418.4 19439.5 19453.6 13563.1 13594.9 13936.8 15223.5 15329.9 18783.9 19671.4 19755.4 19760.8 19880.0 7083.6 7182.9 7329.8 7490.4 7527.8 990.1 998.7 1007.5 1012.1 1015.5 34279.7 34315.3 34316.7 34369.8 35057.3 1162.8 1166.6 1186.4 1190.4 1258.5 17798.8 18065.3 18151.2 18218.5 18326.0 164558.0 164924.0 165281.2 165660.0 166084.0 70276.3 70511.0 71038.6 71112.3 71247.3 1514.8 1526.2 1546.4 1562.6 1563.2 32049.0 33155.0 33430.7 33478.2 33634.3 58945.0 59472.0 59573.0 59716.0 59771.0 422644.0 424579.0 424708.0 425656.0 426508.0 28599.6 31793.7 36995.3 37576.8 39693.2 42863.0 43377.8 47511.0 47730.0 47987.5 39769.6 39937.0 40868.4 41385.4 41422.0 38969.8 38998.8 39462.4 40537.0 40753.4 39487.6 39712.2 39947.6 41339.6 41392.4 34256.8 36262.0 37041.8 37214.6 37687.4 27748.6 27951.7 27978.4 28049.3 28242.9 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | [#2] jquery.html Cycles:180 Average:37245.07 Median:3416.91 stddev:118154.28 (3457.9%) stddev-sans-first:118453.39 09:33:15 INFO - PROCESS | 13013 | Values: 427.4 432.7 434.6 440.2 444.8 20024.9 20773.5 22055.9 22214.3 22339.3 21893.0 23205.3 23263.5 23299.1 23518.6 6083.2 6096.4 6310.2 6314.0 6316.3 6009.4 6122.2 6159.9 6171.7 6172.8 5918.7 6112.3 6119.7 6122.9 6127.2 6095.8 6138.8 6143.8 6144.2 6146.4 5448.3 5493.0 5523.0 5527.3 5538.2 25771.2 26271.6 26325.7 26327.6 26431.9 3284.8 3391.1 3442.7 3468.4 3484.0 11012.1 11160.9 15265.8 15866.8 16584.5 1996.8 2026.7 2040.6 2042.4 2050.8 90013.0 92200.0 92329.0 92355.5 93051.0 12231.2 12422.6 12566.6 12597.9 12793.9 18196.8 18291.3 18380.8 18385.9 18399.9 9448.9 9499.5 9564.4 9634.3 9635.6 9135.3 9195.6 9216.5 9232.0 9434.1 5444.4 5448.9 5489.1 5490.7 5577.6 2190.5 2200.2 2253.3 2260.0 2283.7 920.6 929.9 937.9 946.9 956.1 19865.1 21383.5 21603.1 21632.7 21712.4 955.4 962.6 966.9 983.3 985.8 11591.8 11778.6 11812.6 11896.0 11940.8 517290.0 742689.0 753139.0 765899.0 786120.0 99148.5 100751.0 109679.5 113675.4 114937.4 1145.2 1166.4 1192.3 1193.5 1195.6 19195.4 19483.6 19517.7 19599.3 19709.4 36767.3 39514.2 46134.3 47305.8 48366.3 68147.7 68214.0 69557.0 69570.0 69980.7 8999.6 9063.3 9127.0 9226.0 9372.4 13890.4 14485.1 14519.6 14839.1 15082.0 11455.3 11889.6 11941.4 12006.4 12132.8 11680.2 11710.2 11996.3 12262.4 12842.5 11955.0 12409.9 12536.8 12647.7 12759.2 9098.9 9218.6 9308.9 9350.8 9382.3 11719.4 12004.0 12241.5 12667.7 13023.7 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | [#3] mootools.html Cycles:180 Average:5589.34 Median:4995.52 stddev:3034.26 (60.7%) stddev-sans-first:3026.46 09:33:15 INFO - PROCESS | 13013 | Values: 1403.3 1479.7 1491.5 1510.2 1512.3 7475.9 8070.8 8427.5 8428.5 8632.6 8480.9 8509.5 8530.0 8558.7 8564.6 2080.4 2151.3 2355.4 2394.9 2395.1 2347.4 2421.5 2424.2 2432.6 2443.1 2223.4 2248.9 2258.0 2258.6 2259.0 2345.4 2350.3 2357.4 2364.2 2365.0 2210.9 2360.2 2362.6 2365.2 2366.3 8446.1 8475.8 8487.1 8493.8 8505.2 5098.7 5219.2 5220.4 5221.9 5232.4 3057.0 3241.6 3243.4 3266.4 3283.2 1397.7 1476.8 2135.8 2140.1 2150.5 11392.3 11393.1 11444.4 11462.1 11464.8 4266.2 4505.7 4510.4 4590.1 4606.7 9348.7 9403.0 9409.5 9417.4 9429.9 5270.9 5277.3 5277.8 5278.4 5278.7 4820.0 4828.5 4860.7 4923.0 4924.9 3797.1 3894.3 3897.6 3928.7 3972.2 1187.6 1196.5 1203.4 1212.1 1218.2 957.4 987.6 989.2 992.8 1006.8 5707.3 5732.8 5847.4 5932.9 5967.9 990.7 1018.9 1057.8 1060.5 1110.5 3870.8 3923.9 3924.7 4038.2 4081.2 10096.5 10277.4 10393.2 10399.1 10410.7 10080.8 10234.8 10264.7 10271.0 10279.0 8010.7 8024.1 8116.4 8141.1 8164.7 5396.2 5411.4 5436.0 5465.3 5583.4 9470.3 9475.1 9484.7 9491.0 9561.7 8604.7 9080.2 9351.3 9383.3 9628.1 6827.7 7317.7 7403.9 7508.0 7665.9 8222.7 8266.1 8282.9 8322.8 8347.9 7498.4 7555.2 7561.4 7619.2 7760.6 7246.7 7431.7 7441.4 7444.6 7479.8 6645.9 6708.8 6778.3 6780.4 6786.7 4917.1 4933.6 4940.5 4976.0 5015.0 4941.8 4949.2 5114.5 5125.5 5174.4 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | [#4] prototype.html Cycles:180 Average:4747.48 Median:5367.88 stddev:1361.98 (25.4%) stddev-sans-first:1325.58 09:33:15 INFO - PROCESS | 13013 | Values: 370.1 371.6 371.8 379.0 381.9 5363.6 5372.2 5381.8 5390.1 5418.1 5085.6 5143.8 5214.7 5252.7 5317.4 4240.9 4243.4 4266.9 4277.4 4285.1 4274.0 4277.0 4277.2 4289.2 4304.6 4023.3 4102.5 4272.3 4272.8 4276.5 4232.4 4268.7 4269.6 4298.6 4314.9 3886.1 3895.5 3898.0 3901.6 3923.9 5079.7 5149.9 5151.5 5207.5 5210.4 4881.9 4897.7 4923.3 4923.4 4933.8 5553.2 5573.3 5574.4 5603.2 5610.7 3797.3 3989.7 4051.3 4306.5 4307.4 5674.8 5765.8 5766.4 5790.5 5801.9 4069.6 4075.4 4084.0 4087.4 4095.3 4165.6 4193.0 4195.5 4245.3 4414.6 4890.9 4899.2 4916.6 4935.7 4961.9 5632.8 5633.5 5635.0 5640.5 5669.5 1464.2 1485.7 1492.8 1498.3 1502.4 1014.8 1030.2 1050.5 1084.2 1084.7 5395.2 5410.6 5415.4 5423.6 5447.4 5578.1 5642.4 5642.9 5653.8 5674.5 5125.3 5289.4 5335.3 5362.9 5374.6 2955.9 2957.2 2960.5 2982.7 2988.8 5650.0 5690.3 5814.1 5819.5 5979.0 5860.0 5883.9 5885.2 5921.1 5927.4 5960.3 5969.1 5986.2 6023.9 6036.0 5556.5 5727.6 5734.0 5744.2 5761.5 5634.7 5697.5 5699.4 5702.5 5757.5 5709.5 5890.4 5948.5 5998.1 6017.0 4121.8 4132.9 4148.5 4156.4 4163.6 5785.5 5792.3 5793.7 5804.3 5806.7 5347.8 5631.5 5640.8 5663.8 5668.5 5629.2 5640.9 5644.7 5645.6 5649.2 5401.6 5410.0 5528.8 5595.2 5645.6 5555.3 5556.9 5565.5 5573.0 5573.5 5484.2 5494.6 5526.3 5535.3 5571.0 09:33:15 INFO - PROCESS | 13013 | 09:33:15 INFO - PROCESS | 13013 | [#5] yui.html Cycles:180 Average:18510.80 Median:23474.40 stddev:22938.98 (97.7%) stddev-sans-first:22964.85 09:33:15 INFO - PROCESS | 13013 | Values: 817.0 836.9 853.3 919.4 940.5 15775.3 17331.0 17684.6 17925.6 17991.2 15458.5 15561.5 15687.1 15699.4 15835.8 837.2 849.6 851.5 852.3 852.4 718.7 736.9 820.3 837.0 844.2 891.7 893.0 896.4 897.5 898.1 886.5 888.0 888.4 889.1 889.2 544.1 556.2 627.1 635.9 643.7 17102.8 17614.4 17637.0 17654.2 17668.7 14748.8 15450.3 15557.0 15586.3 15719.0 13473.9 13521.9 13533.5 13551.8 13662.7 3892.7 4490.4 4545.2 4594.1 4670.2 83889.6 84285.6 84975.0 85158.6 86124.6 12426.9 12447.6 12453.7 12519.7 12724.3 23129.4 23210.0 23321.4 23403.3 23577.4 8373.7 8516.4 8549.1 8654.8 8818.3 4791.1 4847.2 4950.9 4960.9 5031.2 3959.9 4069.5 4070.6 4077.0 4078.5 618.3 618.8 620.6 620.8 631.5 858.1 863.4 867.5 869.7 894.9 10934.9 10995.6 11309.5 11820.2 12064.3 826.8 827.5 830.7 833.4 839.2 5291.6 5298.2 5306.3 5361.4 5372.5 82121.6 82179.0 82210.0 82988.6 83958.0 57083.0 58927.4 66686.0 74401.3 74906.3 59030.7 59775.0 60741.0 67423.0 68418.7 10673.3 10947.5 11080.2 11246.9 11249.8 40735.4 41215.0 41241.2 42380.8 42458.4 52673.0 52787.0 56167.4 57264.0 59609.4 13199.9 13241.8 13254.9 13585.5 13681.5 14255.6 14661.9 15055.8 15075.2 15628.2 14766.9 14899.4 15152.9 15428.2 15503.6 14455.9 15260.3 15730.0 15857.0 16381.5 14446.1 14952.5 15574.3 15641.4 15679.2 12411.8 12879.5 12901.5 13044.8 13119.5 11701.9 11983.9 12860.6 13014.7 13189.5 09:33:15 INFO - PROCESS | 13013 | -------- Summary: end -------- 09:33:15 INFO - PROCESS | 13013 | 09:33:16 INFO - TEST-INFO | 13013: exit 0 09:33:16 INFO - TEST-OK | dromaeo_css | took 1114005ms 09:33:16 INFO - TEST-START | kraken 09:33:16 INFO - operating with platform_type : linux_ 09:33:16 INFO - Initialising browser for kraken test... 09:33:16 INFO - TEST-INFO | started process 13334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XMjC6/profile http://localhost:55802/getInfo.html) 09:33:20 INFO - PROCESS | 13334 | __metrics Screen width/height:1600/1200 09:33:20 INFO - PROCESS | 13334 | colorDepth:24 09:33:20 INFO - PROCESS | 13334 | Browser inner width/height: 1024/697 09:33:20 INFO - PROCESS | 13334 | __metrics 09:33:21 INFO - PROCESS | 13334 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:33:21 INFO - PROCESS | 13334 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:22 INFO - TEST-INFO | 13334: exit 0 09:33:22 INFO - Browser initialized. 09:33:22 INFO - Running cycle 1/1 for kraken test... 09:33:22 INFO - TEST-INFO | started process 13426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XMjC6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:34 INFO - PROCESS | 13426 | RSS: Main: 137728000 09:33:34 INFO - PROCESS | 13426 | 09:33:36 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:37 INFO - PROCESS | 13426 | RSS: Main: 181575680 09:33:37 INFO - PROCESS | 13426 | 09:33:40 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-dft) 09:33:40 INFO - PROCESS | 13426 | RSS: Main: 172113920 09:33:40 INFO - PROCESS | 13426 | 09:33:43 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-fft) 09:33:44 INFO - PROCESS | 13426 | RSS: Main: 263675904 09:33:44 INFO - PROCESS | 13426 | 09:33:46 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-oscillator) 09:33:46 INFO - PROCESS | 13426 | RSS: Main: 169541632 09:33:46 INFO - PROCESS | 13426 | 09:33:48 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:49 INFO - PROCESS | 13426 | RSS: Main: 172638208 09:33:49 INFO - PROCESS | 13426 | 09:33:52 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:53 INFO - PROCESS | 13426 | RSS: Main: 211013632 09:33:53 INFO - PROCESS | 13426 | 09:33:56 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:57 INFO - PROCESS | 13426 | RSS: Main: 209633280 09:33:57 INFO - PROCESS | 13426 | 09:33:59 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55802/tests/kraken/driver.html?testName=json-parse-financial) 09:34:00 INFO - PROCESS | 13426 | RSS: Main: 208060416 09:34:00 INFO - PROCESS | 13426 | 09:34:01 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:02 INFO - PROCESS | 13426 | RSS: Main: 170352640 09:34:02 INFO - PROCESS | 13426 | 09:34:04 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:04 INFO - PROCESS | 13426 | RSS: Main: 177942528 09:34:04 INFO - PROCESS | 13426 | 09:34:06 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:07 INFO - PROCESS | 13426 | RSS: Main: 187613184 09:34:07 INFO - PROCESS | 13426 | 09:34:09 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:10 INFO - PROCESS | 13426 | RSS: Main: 196190208 09:34:10 INFO - PROCESS | 13426 | 09:34:13 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:13 INFO - PROCESS | 13426 | RSS: Main: 193122304 09:34:13 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55802/tests/kraken/driver.html?testName=ai-astar) 09:34:15 INFO - PROCESS | 13426 | RSS: Main: 244154368 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | __start_tp_report 09:34:15 INFO - PROCESS | 13426 | _x_x_mozilla_page_load 09:34:15 INFO - PROCESS | 13426 | _x_x_mozilla_page_load_details 09:34:15 INFO - PROCESS | 13426 | |i|pagename|runs| 09:34:15 INFO - PROCESS | 13426 | |0;ai-astar;113;112;113;113;112;112;113;112;113;113 09:34:15 INFO - PROCESS | 13426 | |1;audio-beat-detection;149;117;116;148;119;118;118;116;134;116 09:34:15 INFO - PROCESS | 13426 | |2;audio-dft;159;159;162;162;158;160;159;160;160;159 09:34:15 INFO - PROCESS | 13426 | |3;audio-fft;74;76;74;116;77;77;77;76;90;76 09:34:15 INFO - PROCESS | 13426 | |4;audio-oscillator;82;83;110;84;82;81;96;84;82;115 09:34:15 INFO - PROCESS | 13426 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 09:34:15 INFO - PROCESS | 13426 | |6;imaging-darkroom;145;146;145;147;146;147;145;146;146;146 09:34:15 INFO - PROCESS | 13426 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;96;96 09:34:15 INFO - PROCESS | 13426 | |8;json-parse-financial;49;50;50;49;49;49;49;49;50;49 09:34:15 INFO - PROCESS | 13426 | |9;json-stringify-tinderbox;63;62;62;63;64;62;63;63;63;63 09:34:15 INFO - PROCESS | 13426 | |10;stanford-crypto-aes;79;77;75;80;78;78;75;74;81;79 09:34:15 INFO - PROCESS | 13426 | |11;stanford-crypto-ccm;121;128;124;123;125;128;126;120;161;129 09:34:15 INFO - PROCESS | 13426 | |12;stanford-crypto-pbkdf2;160;159;156;157;156;160;155;162;157;159 09:34:15 INFO - PROCESS | 13426 | |13;stanford-crypto-sha256-iterative;64;61;62;63;63;60;61;61;59;63 09:34:15 INFO - PROCESS | 13426 | __end_tp_report 09:34:15 INFO - PROCESS | 13426 | __start_cc_report 09:34:15 INFO - PROCESS | 13426 | _x_x_mozilla_cycle_collect,1524 09:34:15 INFO - PROCESS | 13426 | __end_cc_report 09:34:15 INFO - PROCESS | 13426 | __startTimestamp1488735255836__endTimestamp 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | ------- Summary: start ------- 09:34:15 INFO - PROCESS | 13426 | Number of tests: 14 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:34:15 INFO - PROCESS | 13426 | Values: 113.0 112.0 113.0 113.0 112.0 112.0 113.0 112.0 113.0 113.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:118.50 stddev:13.44 (11.3%) stddev-sans-first:11.14 09:34:15 INFO - PROCESS | 13426 | Values: 149.0 117.0 116.0 148.0 119.0 118.0 118.0 116.0 134.0 116.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 09:34:15 INFO - PROCESS | 13426 | Values: 159.0 159.0 162.0 162.0 158.0 160.0 159.0 160.0 160.0 159.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.50 stddev:13.02 (17.0%) stddev-sans-first:13.54 09:34:15 INFO - PROCESS | 13426 | Values: 74.0 76.0 74.0 116.0 77.0 77.0 77.0 76.0 90.0 76.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.50 stddev:12.71 (15.4%) stddev-sans-first:13.16 09:34:15 INFO - PROCESS | 13426 | Values: 82.0 83.0 110.0 84.0 82.0 81.0 96.0 84.0 82.0 115.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:34:15 INFO - PROCESS | 13426 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 09:34:15 INFO - PROCESS | 13426 | Values: 145.0 146.0 145.0 147.0 146.0 147.0 145.0 146.0 146.0 146.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:34:15 INFO - PROCESS | 13426 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.00 stddev:0.48 (1.0%) stddev-sans-first:0.50 09:34:15 INFO - PROCESS | 13426 | Values: 49.0 50.0 50.0 49.0 49.0 49.0 49.0 49.0 50.0 49.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:34:15 INFO - PROCESS | 13426 | Values: 63.0 62.0 62.0 63.0 64.0 62.0 63.0 63.0 63.0 63.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.50 stddev:2.32 (3.0%) stddev-sans-first:2.40 09:34:15 INFO - PROCESS | 13426 | Values: 79.0 77.0 75.0 80.0 78.0 78.0 75.0 74.0 81.0 79.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:127.00 stddev:11.81 (9.3%) stddev-sans-first:12.21 09:34:15 INFO - PROCESS | 13426 | Values: 121.0 128.0 124.0 123.0 125.0 128.0 126.0 120.0 161.0 129.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:159.00 stddev:2.23 (1.4%) stddev-sans-first:2.26 09:34:15 INFO - PROCESS | 13426 | Values: 160.0 159.0 156.0 157.0 156.0 160.0 155.0 162.0 157.0 159.0 09:34:15 INFO - PROCESS | 13426 | 09:34:15 INFO - PROCESS | 13426 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.50 stddev:1.57 (2.5%) stddev-sans-first:1.42 09:34:15 INFO - PROCESS | 13426 | Values: 64.0 61.0 62.0 63.0 63.0 60.0 61.0 61.0 59.0 63.0 09:34:15 INFO - PROCESS | 13426 | -------- Summary: end -------- 09:34:15 INFO - PROCESS | 13426 | 09:34:16 INFO - TEST-INFO | 13426: exit 0 09:34:16 INFO - TEST-OK | kraken | took 60414ms 09:34:16 INFO - SUITE-END | took 1174s 09:34:16 INFO - Completed test suite (00:19:34) 09:34:17 INFO - javascript benchmark 09:34:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.406106900757, 3308.5533452983846, 3321.701046905778, 3351.9162020949475, 3354.0, 5443.319585051869, 5493.1760235964575, 5501.092319767234, 5509.6969666668265, 5516.282883225185, 5419.5393391561765, 5477.863053423666, 5496.835094947158, 5514.228008078872, 5525.889482210353, 5013.172826483626, 5033.874153146164, 5067.49325067494, 5110.412302585194, 5125.692458452505, 5004.449510553836, 5070.112730272188, 5127.333446651949, 5129.769160387773, 5131.7690703918415, 4945.7032578045255, 4963.0, 4964.0816448956875, 4968.6025117990475, 5019.472955339692, 5006.3241462402475, 5076.568491678193, 5086.3133476980875, 5087.56755675768, 5113.872153196163, 4931.457539670633, 4959.0, 5053.772580233898, 5062.417821950486, 5065.037642847848, 5369.489898459679, 5374.6506477078865, 5410.594205434608, 5416.458354164592, 5429.511343979061, 5849.678267695275, 5884.911726324109, 5896.734646940898, 5899.970500147472, 5930.199423077873, 5933.495652869511, 5940.079287710412, 5941.613795103348, 5948.167256584082, 5948.40515948406, 5325.121354976463, 5353.822159125025, 5426.620136590401, 5461.2627295315415, 5542.140968149944, 5969.611975221596, 5970.373110823388, 5971.880562388728, 6007.249093863267, 6008.579399441997, 5749.942500574941, 5755.65466072037, 5756.280464941882, 5762.078067509262, 5766.625169363978, 5678.943210567924, 5694.715264236855, 5794.333651630117, 5862.120681897664, 5863.355030946593, 5866.0, 5886.529077673776, 5935.2877654681715, 5965.13505541694, 5974.163617093611, 5938.346781853993, 5947.672877991666, 5948.434898684618, 5948.7323070461935, 5953.255843019622, 4453.309736990772, 4503.909921801545, 4555.840545580889, 4570.337301091323, 4578.702384345007, 4023.4970628671417, 4047.0894048838777, 4051.6758659307775, 4070.674346052309, 4099.036726369361, 5711.3146422428745, 5723.971380143073, 5724.169995350734, 5726.828195154152, 5745.080787074048, 5752.194692743019, 5772.249607550992, 5822.563307751935, 5914.319853216935, 5914.822555323347, 5629.043062679354, 5655.462731040545, 5655.717214139277, 5688.203651488795, 5697.829065127969, 4975.626827987915, 4979.128652485801, 4991.9500804991485, 4994.200927851526, 5027.673201241908, 5958.255218097738, 6024.698765061729, 6054.091886217103, 6067.54493412987, 6085.208922840003, 5859.2090067842, 5909.3795151508475, 5911.05423132314, 5994.880102398015, 6034.939650603438, 6169.183052726672, 6198.349173336735, 6203.844903877439, 6204.348543402878, 6207.224096987877, 5661.235733176133, 5836.387179346108, 5886.529077673861, 5890.087036509348, 5918.7928422505, 5783.971080144573, 5840.707964601838, 5867.970660146672, 5879.588428809942, 5966.134910438049, 5716.5998380113, 5793.8551536211935, 5803.448672376117, 5805.158252053344, 5808.332041815245, 5720.08478643415, 5766.0, 5767.250257466502, 5772.336181339199, 5774.133879918046, 5603.0474819281635, 5612.579056570855, 5719.428057194414, 5724.141378793214, 5732.57005724564, 5819.5344372450945, 5836.299644042742, 5839.474447299764, 5855.560832937632, 5857.0, 5714.657120572779, 5717.771289148387, 5731.455511726379, 5736.8278951629845, 5737.885242295048], "value": 5448.000536174371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.3559933700338, 578.4562511239435, 603.1887111834583, 612.8529153003278, 630.010882913825, 36420.0, 46901.0, 47946.041079178394, 47986.280205796895, 48153.277700834515, 50532.242016369695, 50989.490105098936, 51117.48882511174, 51124.74437627816, 51212.0, 8759.693410730626, 8992.460452372847, 9441.575129119206, 9645.758856028586, 9648.903510964907, 11060.281081729701, 11346.149038822081, 11349.943250283737, 11766.588169414072, 11776.175667703264, 11588.942055289712, 11672.941635291812, 11675.299482031105, 11675.474603642813, 11682.12384071198, 11398.601048963288, 11399.943000285028, 11453.541858325658, 11462.140339474572, 11464.71338216543, 11282.097432205486, 11356.375399353032, 11371.829422558669, 11374.71563210918, 11385.715357116056, 46771.0, 47254.0, 47262.29106563405, 47307.0, 47321.29018064732, 4417.271150260203, 4486.753228572427, 4519.593236608721, 4581.266997280419, 4714.363560919266, 32362.83818580892, 32471.863484777918, 32719.018429447155, 32737.0, 33574.6642533574, 4654.767261636938, 4666.883327916796, 4698.8355407560575, 4730.668853180278, 4790.712557246541, 357076.0, 358489.0, 358880.0, 359110.0, 359242.0, 60135.097973530435, 60310.0, 60458.39541604616, 60481.69759151176, 60585.99999999912, 63127.0, 63149.0, 63205.0, 63328.36671633317, 63336.36663633305, 19120.2351905925, 19402.0, 19418.417447476597, 19439.514012149528, 19453.610927781367, 13563.118397304144, 13594.864051359558, 13936.790948135786, 15223.467178648694, 15329.923350383177, 18783.90608046951, 19671.409857704293, 19755.40733777989, 19760.802391975896, 19880.0, 7083.610401427971, 7182.856342873113, 7329.8010596821805, 7490.363319117827, 7527.849443011219, 990.1435258501344, 998.6554638649654, 1007.4559737741685, 1012.0840639221516, 1015.5176291261591, 34279.65720342815, 34315.313693725984, 34316.65683343135, 34369.82815085958, 35057.298854023284, 1162.7906976744268, 1166.6150170443734, 1186.4423720851187, 1190.434543591787, 1258.4903114238748, 17798.783797917094, 18065.2773889043, 18151.183196756177, 18218.544536386697, 18326.0, 164558.0, 164924.0, 165281.17359413125, 165660.0, 166084.0, 70276.297237028, 70511.0, 71038.64480677668, 71112.2888771116, 71247.2875271251, 1514.8182218133895, 1526.1606116635805, 1546.420092465303, 1562.6015366081576, 1563.241827713558, 32049.0, 33155.00534983954, 33430.665693343726, 33478.16304592405, 33634.327313453105, 58945.0, 59472.0, 59573.0, 59716.0, 59771.0, 422644.0, 424579.0, 424708.0, 425656.0, 426508.0, 28599.571006434504, 31793.682063179072, 36995.26009479741, 37576.81211594034, 39693.2061358777, 42863.0, 43377.783111084245, 47511.0, 47730.0, 47987.520124798306, 39769.60230397659, 39937.0, 40868.38697419601, 41385.37921931113, 41422.0, 38969.80515097406, 38998.80500597479, 39462.40806387849, 40537.0, 40753.38869917013, 39487.60512394839, 39712.2057558853, 39947.60052399439, 41339.586604133576, 41392.37911431391, 34256.82871585626, 36262.0, 37041.814790926954, 37214.63577578651, 37687.434688479145, 27748.583771243044, 27951.72048279491, 27978.440431190855, 28049.29876753016, 28242.85878570594], "value": 21115.64922842527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.37176350764366, 432.71008424355676, 434.63558243157223, 440.15490258703295, 444.8265176581132, 20024.89987550062, 20773.480662983413, 22055.889720551415, 22214.333569992887, 22339.329820105402, 21893.0, 23205.303840884757, 23263.534729305404, 23299.068037278532, 23518.64722029171, 6083.20918280624, 6096.390360963913, 6310.242770867502, 6314.02132669437, 6316.30520642729, 6009.429104235091, 6122.234720659918, 6159.8768024639485, 6171.7222724977255, 6172.783952561661, 5918.674472903988, 6112.297085835119, 6119.663418512002, 6122.877542449149, 6127.172831667713, 6095.7561697532265, 6138.84652883677, 6143.815685529419, 6144.170536977495, 6146.446819786218, 5448.346198456171, 5493.0, 5523.0, 5527.309086364205, 5538.224648549206, 25771.226863194133, 26271.605925911128, 26325.73674263252, 26327.605085923726, 26431.867840660867, 3284.83575821208, 3391.1183092396154, 3442.707369873564, 3468.4277094279414, 3484.0244731475227, 11012.119030477543, 11160.944195279053, 15265.771013434807, 15866.761998570031, 16584.50246492607, 1996.8302694271003, 2026.695995600657, 2040.6020825938947, 2042.4485388944902, 2050.76416212136, 90013.0, 92200.0, 92329.0, 92355.53822230913, 93051.0, 12231.204971676812, 12422.565210217599, 12566.560170393992, 12597.87402125967, 12793.872061279455, 18196.818031819777, 18291.262330078887, 18380.816191838177, 18385.90807045983, 18399.90800046018, 9448.905510944802, 9499.530122168147, 9564.378315409476, 9634.277429192838, 9635.614575416905, 9135.269178465707, 9195.586198621078, 9216.493092879957, 9231.953840230755, 9434.103760142776, 5444.40111587725, 5448.918266225931, 5489.1217405214975, 5490.670559766427, 5577.553795696334, 2190.539986602799, 2200.1969281212564, 2253.3465295064248, 2260.011190152655, 2283.7259528856644, 920.6133423961952, 929.9349045566745, 937.8593211018265, 946.9431834089977, 956.086936975187, 19865.106070226873, 21383.46541336479, 21603.140181721817, 21632.675509867364, 21712.394512658266, 955.441066975827, 962.5716556132454, 966.9226461883032, 983.331334692416, 985.8028394321165, 11591.84081591851, 11778.587749428729, 11812.645620631394, 11896.0, 11940.820887686517, 517290.0, 742689.0, 753139.0, 765899.0, 786120.0, 99148.5042574797, 100750.99999999853, 109679.45160274148, 113675.43162284135, 114937.4253128729, 1145.238416453066, 1166.4401087477888, 1192.3382522699812, 1193.498730533178, 1195.6114262864603, 19195.424137275902, 19483.61032779365, 19517.70723439121, 19599.31402400909, 19709.40871773849, 36767.264654707295, 39514.2097158061, 46134.30798538092, 47305.7634711838, 48366.27450588174, 68147.65926170337, 68214.0, 69557.0, 69570.0, 69980.65009674919, 8999.64001439935, 9063.320250981335, 9127.0, 9225.953870230605, 9372.39079459833, 13890.374933127832, 14485.130892146504, 14519.637009074857, 14839.10965342083, 15082.0, 11455.312681239153, 11889.643310700692, 11941.402929853646, 12006.399680016139, 12132.818007730068, 11680.240784348991, 11710.180287379802, 11996.340201289013, 12262.4481898313, 12842.486300547873, 11955.0, 12409.875901240872, 12536.811947820972, 12647.747045058863, 12759.234445933274, 9098.863517047117, 9218.585163667785, 9308.860367094634, 9350.812983740423, 9382.343235973416, 11719.414029298672, 12004.039676826007, 12241.510339586674, 12667.746645066863, 13023.739525209632], "value": 10335.660577395169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.319390095804, 1479.7188534178506, 1491.4779827060527, 1510.192047254719, 1512.2589930933843, 7475.887861682072, 8070.798230044252, 8427.494350338984, 8428.452150610206, 8632.611532481038, 8480.872786908201, 8509.489430634167, 8530.019047809505, 8558.743237702864, 8564.614592343343, 2080.355089922129, 2151.343840128768, 2355.422921384263, 2394.928152155438, 2395.053953688292, 2347.4366152123453, 2421.5278020785954, 2424.1636635360774, 2432.6472661464077, 2443.1082654831034, 2223.3552269841725, 2248.87631180285, 2258.0177622734163, 2258.627326491135, 2258.977410225901, 2345.3901985483812, 2350.2949115265524, 2357.446000189954, 2364.1843563970488, 2364.9763502364926, 2210.9005094770614, 2360.173939121311, 2362.61016932206, 2365.1958334166466, 2366.3019409274307, 8446.113158118433, 8475.830483390298, 8487.066422693499, 8493.83012339756, 8505.192006759347, 5098.719570423626, 5219.19102539107, 5220.3735551734035, 5221.947780522184, 5232.398274198478, 3056.9847150764326, 3241.6434192238835, 3243.4486137356707, 3266.4283750343834, 3283.1627934876456, 1397.6715471864104, 1476.75633520469, 2135.8291336693183, 2140.1332460353583, 2150.5268840854988, 11392.259503132353, 11393.145514086476, 11444.370559619301, 11462.083033357312, 11464.828027579593, 4266.210751011073, 4505.684602077823, 4510.413646225969, 4590.059037897223, 4606.723596584216, 9348.719538413858, 9403.0, 9409.48247846375, 9417.434953902788, 9429.90570094304, 5270.868228294324, 5277.287566178594, 5277.8416647500635, 5278.366596008504, 5278.709670968134, 4819.95180048202, 4828.5412885775795, 4860.659753817199, 4923.040007198562, 4924.8768780780765, 3797.1266608680157, 3894.3184942634925, 3897.649211570972, 3928.744631598937, 3972.1857019310974, 1187.5962172861268, 1196.491491116272, 1203.4404002138872, 1212.115155936154, 1218.226426219357, 957.3872721458272, 987.6247026130025, 989.2382865193761, 992.8262554053011, 1006.8288390973552, 5707.258056452718, 5732.77068917247, 5847.444492773265, 5932.911006334908, 5967.850803729854, 990.7126933189294, 1018.9133923616428, 1057.8095942730383, 1060.4782137632521, 1110.5002748763088, 3870.825812838429, 3923.862664806718, 3924.6664033557468, 4038.2327357801923, 4081.2041651878194, 10096.545655445523, 10277.383356998604, 10393.16854651626, 10399.116075133546, 10410.68767936963, 10080.798384032278, 10234.846477302846, 10264.743381415525, 10271.0, 10279.0, 8010.679572817022, 8024.117347091932, 8116.391270654606, 8141.063777665526, 8164.67341306353, 5396.244525766474, 5411.377691565521, 5436.0, 5465.262189604353, 5583.385827558884, 9470.337076404585, 9475.099865512766, 9484.668036618685, 9491.0, 9561.665341713007, 8604.741857744277, 9080.182783549248, 9351.298652600946, 9383.34316597859, 9628.133467987915, 6827.658617069027, 7317.670704818403, 7403.925960740539, 7508.0, 7665.885011724717, 8222.671093156207, 8266.090730019572, 8282.875756863772, 8322.750317490485, 8347.874781878398, 7498.437617178624, 7555.16893141743, 7561.357284630868, 7619.1999840016, 7760.573168475788, 7246.673899674633, 7431.665575049244, 7441.404687625085, 7444.590547519939, 7479.775606731807, 6645.933540664531, 6708.83227919306, 6778.254392016973, 6780.38976492118, 6786.694598743167, 4917.139500587455, 4933.58064564516, 4940.530649588283, 4976.0, 5015.04714104319, 4941.75291235444, 4949.1586430306215, 5114.539691427789, 5125.513076257749, 5174.353205849269], "value": 4578.95297864108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.0766587364526, 371.5893937199396, 371.8438255932508, 378.9791561464119, 381.89497888080774, 5363.570914326854, 5372.194170874371, 5381.838544843651, 5390.137577987513, 5418.106012507931, 5085.61857860661, 5143.7912090658665, 5214.71472972028, 5252.737363131838, 5317.415084340729, 4240.936385954213, 4243.363495475673, 4266.885173823111, 4277.379779931915, 4285.121550082241, 4273.978630106845, 4276.97861510692, 4277.165952639237, 4289.227938970984, 4304.634106100985, 4023.3160362738404, 4102.528209255944, 4272.252355837732, 4272.807723652443, 4276.465441819772, 4232.428622136018, 4268.658507319407, 4269.615734583902, 4298.613124818781, 4314.892127696801, 3886.125621735115, 3895.4935858338517, 3898.0, 3901.5708272090046, 3923.862664806718, 5079.6698214615935, 5149.922751158736, 5151.5106064923775, 5207.515857980496, 5210.374755029383, 4881.8535443936735, 4897.706137631718, 4923.286123512106, 4923.384576927884, 4933.753312334405, 5553.16702494625, 5573.27547418833, 5574.414686457944, 5603.2435621191025, 5610.663360198401, 3797.259534390795, 3989.7207195496326, 4051.3315302974975, 4306.5478124796755, 4307.440032795748, 5674.829755107395, 5765.827025189251, 5766.4430603736755, 5790.478856902857, 5801.854953626151, 4069.552349241581, 4075.449814275094, 4083.9795801020805, 4087.4277601135864, 4095.3242714952294, 4165.58344165581, 4192.958070419318, 4195.454590903163, 4245.341971994346, 4414.55854414556, 4890.902181956341, 4899.191633380524, 4916.582090522345, 4935.703857768545, 4961.875953101201, 5632.774689012475, 5633.492985631313, 5634.971825140848, 5640.492355688008, 5669.546436285087, 1464.1727424005403, 1485.6508720450686, 1492.79847220626, 1498.2658497336226, 1502.4140585171792, 1014.8122597319519, 1030.1912998296302, 1050.485262221506, 1084.219362059316, 1084.6854412220525, 5395.217693434509, 5410.567154627621, 5415.377231618336, 5423.566114710814, 5447.428020057916, 5578.079616863172, 5642.379338272786, 5642.915356269659, 5653.802116925888, 5674.4892959633835, 5125.282460455539, 5289.3917199521775, 5335.306410166731, 5362.9084656983805, 5374.5700343972385, 2955.940881182364, 2957.2459022949442, 2960.5411161270035, 2982.7166419190144, 2988.8194163305375, 5650.039493286151, 5690.3013041523345, 5814.098814683731, 5819.53443724501, 5978.970105149533, 5860.011394188909, 5883.940890639726, 5885.176075349455, 5921.082232254007, 5927.436893495111, 5960.331107289966, 5969.134475501028, 5986.191864098291, 6023.939760602338, 6036.004059330161, 5556.499915007668, 5727.599068065362, 5734.0, 5744.167095771007, 5761.5390768739235, 5634.718264086698, 5697.515711164431, 5699.373068962328, 5702.486776190163, 5757.481826635623, 5709.51469125129, 5890.381509941394, 5948.494377977747, 5998.1105951625095, 6017.0, 4121.793910304533, 4132.876013719593, 4148.522919864255, 4156.418101465858, 4163.646090082377, 5785.450382213683, 5792.304923409218, 5793.681347525927, 5804.332501762351, 5806.738696758572, 5347.759350829144, 5631.493165615114, 5640.774369025193, 5663.801766938137, 5668.546516278605, 5629.183768353648, 5640.869317528811, 5644.717764111861, 5645.616823878177, 5649.152627105803, 5401.567874569946, 5410.0, 5528.778848846001, 5595.244641973444, 5645.604807663424, 5555.250041244381, 5556.861078472909, 5565.499105080562, 5572.972135139298, 5573.498385145356, 5484.177373394023, 5494.642848214853, 5526.3420973706925, 5535.308086489189, 5570.991664501124], "value": 4330.105706383754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.9509829410235, 836.9414141010132, 853.3301358433631, 919.3702313914969, 940.4780346907465, 15775.290111944962, 17331.046792426412, 17684.646307073883, 17925.641487170247, 17991.19039643216, 15458.458953936586, 15561.53315400537, 15687.137207453585, 15699.37202511898, 15835.762463563056, 837.1879277101202, 849.617672047578, 851.4678326046221, 852.2755657690975, 852.4033176776251, 718.6801873166443, 736.8968344431784, 820.2945466898492, 836.9748907532753, 844.2106630300658, 891.6611687558751, 892.9508877011762, 896.4352457951481, 897.5377680494518, 898.0884402331639, 886.4814083761007, 888.0320450708726, 888.4358432395411, 889.0664801957982, 889.1997202517754, 544.1484077418827, 556.1629747230432, 627.078195053271, 635.8569321902581, 643.7296335539038, 17102.82897171025, 17614.383496577557, 17637.02996335201, 17654.20556074967, 17668.734968975477, 14748.778768318483, 15450.304736286895, 15557.0, 15586.298616562282, 15719.0, 13473.932630336785, 13521.864781352257, 13533.458661653522, 13551.796723049161, 13662.658433539142, 3892.7469714468752, 4490.438695163105, 4545.2273113570445, 4594.104149690812, 4670.229412146991, 83889.58055209745, 84285.57857210675, 84975.0, 85158.57420712856, 86124.56937715334, 12426.937865310796, 12447.626571202878, 12453.688657783629, 12519.749605007848, 12724.300163491096, 23129.421764456023, 23210.0, 23321.416964576023, 23403.297901062997, 23577.406485286603, 8373.706920257884, 8516.361272904556, 8549.059603443617, 8654.82690346202, 8818.29453643707, 4791.137595232892, 4847.224444088999, 4950.925736113961, 4960.925586116211, 5031.245313202976, 3959.9406008909314, 4069.5320038195987, 4070.5725898780793, 4077.0, 4078.46979892618, 618.2704408797572, 618.7617767159586, 620.5687047502033, 620.7796232337546, 631.5137344244906, 858.0689951402798, 863.4171933944563, 867.492516877621, 869.6521391443473, 894.8881389826272, 10934.890651093547, 10995.615153469591, 11309.547618095348, 11820.172587918763, 12064.276143431247, 826.7891687619739, 827.4828232354778, 830.667732906842, 833.3874602167402, 839.1608391608391, 5291.629585929025, 5298.178782288752, 5306.293371620048, 5361.437049109865, 5372.516473517324, 82121.58939205266, 82179.0, 82210.0, 82988.58505707434, 83958.0, 57083.0, 58927.410725892194, 66686.0, 74401.25598744051, 74906.25093748992, 59030.70484647635, 59775.0, 60740.99999999912, 67423.0, 68418.65790671014, 10673.306235094695, 10947.507362168562, 11080.224384293344, 11246.943765281121, 11249.831252531056, 40735.38896916608, 41215.0, 41241.1751764969, 42380.788096059325, 42458.36312455254, 52673.0, 52787.0, 56167.436097288526, 57264.0, 59609.40390596212, 13199.868001319865, 13241.801372979606, 13254.867451325363, 13585.45658173662, 13681.521146759816, 14255.64360890986, 14661.85338146605, 15055.77416338734, 15075.24623768829, 15628.218589070273, 14766.852331476977, 14899.404023838924, 15152.912705615077, 15428.151451670266, 15503.612409689847, 14455.85544144545, 15260.313285902383, 15730.0, 15857.0, 16381.508554743377, 14446.061524352659, 14952.476663316731, 15574.299156538209, 15641.374345026526, 15679.216039198223, 12411.751764964469, 12879.549215777777, 12901.483940642269, 13044.804327935279, 13119.475220991053, 11701.941490292495, 11983.940080299542, 12860.614181574567, 13014.674633134247, 13189.538366157138], "value": 7828.915439509316, "unit": "score"}], "name": "dromaeo_css", "value": 7545.689777480263, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 116.0, 148.0, 119.0, 118.0, 118.0, 116.0, 134.0, 116.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 162.0, 162.0, 158.0, 160.0, 159.0, 160.0, 160.0, 159.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 116.0, 77.0, 77.0, 77.0, 76.0, 90.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 110.0, 84.0, 82.0, 81.0, 96.0, 84.0, 82.0, 115.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 49.0, 49.0, 49.0, 49.0, 49.0, 50.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 75.0, 80.0, 78.0, 78.0, 75.0, 74.0, 81.0, 79.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 124.0, 123.0, 125.0, 128.0, 126.0, 120.0, 161.0, 129.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 156.0, 157.0, 156.0, 160.0, 155.0, 162.0, 157.0, 159.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 63.0, 63.0, 60.0, 61.0, 61.0, 59.0, 63.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1464.8999999999999, "alertThreshold": 2.0}]} 09:34:17 INFO - Return code: 0 09:34:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:17 ERROR - # TBPL SUCCESS # 09:34:17 INFO - Running post-action listener: _resource_record_post_action 09:34:17 INFO - [mozharness: 2017-03-05 17:34:17.140285Z] Finished run-tests step (success) 09:34:17 INFO - Running post-run listener: _resource_record_post_run 09:34:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 381648896; Read time: 196; Write time: 217320 09:34:17 INFO - TinderboxPrint: CPU usage
13.0% 09:34:17 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 196 09:34:17 INFO - TinderboxPrint: I/O write bytes / time
381,648,896 / 217,320 09:34:17 INFO - TinderboxPrint: CPU idle
8,270.4 (87.0%) 09:34:17 INFO - TinderboxPrint: CPU user
1,189.9 (12.5%) 09:34:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:34:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109568000; Read time: 188; Write time: 96568 09:34:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 254259200; Read time: 8; Write time: 115604 09:34:17 INFO - Running post-run listener: _upload_blobber_files 09:34:17 INFO - Blob upload gear active. 09:34:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:17 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 09:34:17 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:34:17 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:34:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:34:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:34:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:18 INFO - (blobuploader) - INFO - Done attempting. 09:34:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:34:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:19 INFO - (blobuploader) - INFO - Done attempting. 09:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:20 INFO - (blobuploader) - INFO - Done attempting. 09:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:34:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:23 INFO - (blobuploader) - INFO - Done attempting. 09:34:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:34:23 INFO - Return code: 0 09:34:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:34:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:34:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99e8950d492915f4879ebeb197018b49d9f44e12db31dd0834d6f708f32ecc179c6b7dbd676c752a350a1d7c7af5ca28bb36c179f0f23cff2c5d65d8f4b147c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ce3af230975147754cbdc347267ec9b455b0ef9234da862d53fac3c73ae8e102f90b0de1996478ed265fe95f402ff3075d9953e1a1cf61e56da05e378207e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572c01d69e0f65061adadbffb1ee3a7234c6d215879ca9ea416e604428b40cb5ca5bb6f7af2a922ba9a0e09712b62e96f817b76f17465bdc8116d041bacf1bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67cb75e125d181541fe63c70e7ec159992b934442b8db3bef7d0f6e90a50697b21468a39b4d75b2c9a139077afd8eb52c67333280545b44f1f56ccdb10d88773"} 09:34:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:34:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:34:23 INFO - Contents: 09:34:23 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99e8950d492915f4879ebeb197018b49d9f44e12db31dd0834d6f708f32ecc179c6b7dbd676c752a350a1d7c7af5ca28bb36c179f0f23cff2c5d65d8f4b147c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ce3af230975147754cbdc347267ec9b455b0ef9234da862d53fac3c73ae8e102f90b0de1996478ed265fe95f402ff3075d9953e1a1cf61e56da05e378207e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572c01d69e0f65061adadbffb1ee3a7234c6d215879ca9ea416e604428b40cb5ca5bb6f7af2a922ba9a0e09712b62e96f817b76f17465bdc8116d041bacf1bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67cb75e125d181541fe63c70e7ec159992b934442b8db3bef7d0f6e90a50697b21468a39b4d75b2c9a139077afd8eb52c67333280545b44f1f56ccdb10d88773"} 09:34:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:34:23 INFO - Copying logs to upload dir... 09:34:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:34:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.538382 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-03-05 09:34:23.101329) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 09:34:23.106187) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99e8950d492915f4879ebeb197018b49d9f44e12db31dd0834d6f708f32ecc179c6b7dbd676c752a350a1d7c7af5ca28bb36c179f0f23cff2c5d65d8f4b147c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ce3af230975147754cbdc347267ec9b455b0ef9234da862d53fac3c73ae8e102f90b0de1996478ed265fe95f402ff3075d9953e1a1cf61e56da05e378207e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572c01d69e0f65061adadbffb1ee3a7234c6d215879ca9ea416e604428b40cb5ca5bb6f7af2a922ba9a0e09712b62e96f817b76f17465bdc8116d041bacf1bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67cb75e125d181541fe63c70e7ec159992b934442b8db3bef7d0f6e90a50697b21468a39b4d75b2c9a139077afd8eb52c67333280545b44f1f56ccdb10d88773"} build_url:https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/HVbmf-WUSWmdi_YxZHbQKQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99e8950d492915f4879ebeb197018b49d9f44e12db31dd0834d6f708f32ecc179c6b7dbd676c752a350a1d7c7af5ca28bb36c179f0f23cff2c5d65d8f4b147c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ce3af230975147754cbdc347267ec9b455b0ef9234da862d53fac3c73ae8e102f90b0de1996478ed265fe95f402ff3075d9953e1a1cf61e56da05e378207e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572c01d69e0f65061adadbffb1ee3a7234c6d215879ca9ea416e604428b40cb5ca5bb6f7af2a922ba9a0e09712b62e96f817b76f17465bdc8116d041bacf1bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67cb75e125d181541fe63c70e7ec159992b934442b8db3bef7d0f6e90a50697b21468a39b4d75b2c9a139077afd8eb52c67333280545b44f1f56ccdb10d88773"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 09:34:23.135306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:34:23.136021) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1488720731.435457-1732620437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:34:23.218115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 09:34:23.218415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 09:34:23.218721) ========= ========= Total master_lag: 0.16 =========