builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1491579981.22 results: success (0) revision: 19e555dcd7e28ffae4440fb2220f1671cb81d6de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.219409) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.219830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.220098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.234845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.235128) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-07 08:46:21-- 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% 222M=0s 2017-04-07 08:46:21 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075986 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.324823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.325148) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014378 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:21.375357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 08:46:21.375685) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19e555dcd7e28ffae4440fb2220f1671cb81d6de --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 19e555dcd7e28ffae4440fb2220f1671cb81d6de --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-07 08:46:21,443 truncating revision to first 12 chars 2017-04-07 08:46:21,443 Setting DEBUG logging. 2017-04-07 08:46:21,443 attempt 1/10 2017-04-07 08:46:21,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19e555dcd7e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 08:46:22,347 unpacking tar archive at: mozilla-central-19e555dcd7e2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.181915 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 08:46:22.570963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:22.571338) ========= script_repo_revision: 19e555dcd7e28ffae4440fb2220f1671cb81d6de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:22.571719) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:22.571981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 08:46:22.581671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-07 08:46:22.581951) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:22 INFO - MultiFileLogger online at 20170407 08:46:22 in /builds/slave/test 08:46:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:46:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:22 INFO - {'append_to_log': False, 08:46:22 INFO - 'base_work_dir': '/builds/slave/test', 08:46:22 INFO - 'blob_upload_branch': 'Firefox', 08:46:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:22 INFO - 'branch': 'Firefox', 08:46:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:22 INFO - 'config_files': ('talos/linux_config.py',), 08:46:22 INFO - 'default_actions': ('clobber', 08:46:22 INFO - 'read-buildbot-config', 08:46:22 INFO - 'download-and-extract', 08:46:22 INFO - 'populate-webroot', 08:46:22 INFO - 'create-virtualenv', 08:46:22 INFO - 'install', 08:46:22 INFO - 'run-tests'), 08:46:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:22 INFO - 'download_minidump_stackwalk': True, 08:46:22 INFO - 'download_symbols': 'ondemand', 08:46:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:22 INFO - 'gecko_profile': False, 08:46:22 INFO - 'gecko_profile_interval': 0, 08:46:22 INFO - 'installer_path': 'installer.exe', 08:46:22 INFO - 'log_level': 'info', 08:46:22 INFO - 'log_name': 'talos', 08:46:22 INFO - 'log_to_console': True, 08:46:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:22 INFO - 'opt_config_files': (), 08:46:22 INFO - 'pip_index': False, 08:46:22 INFO - 'suite': 'dromaeojs', 08:46:22 INFO - 'system_bits': '32', 08:46:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:22 INFO - 'title': 'talos-linux64-ix-001', 08:46:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:22 INFO - 'use_talos_json': True, 08:46:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:22 INFO - 'work_dir': 'build'} 08:46:22 INFO - [mozharness: 2017-04-07 15:46:22.753185Z] Running clobber step. 08:46:22 INFO - Running pre-action listener: _resource_record_pre_action 08:46:22 INFO - Running main action method: clobber 08:46:22 INFO - rmtree: /builds/slave/test/build 08:46:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:23 INFO - Running post-action listener: _resource_record_post_action 08:46:23 INFO - [mozharness: 2017-04-07 15:46:23.675906Z] Finished clobber step (success) 08:46:23 INFO - [mozharness: 2017-04-07 15:46:23.676009Z] Running read-buildbot-config step. 08:46:23 INFO - Running pre-action listener: _resource_record_pre_action 08:46:23 INFO - Running main action method: read_buildbot_config 08:46:23 INFO - Using buildbot properties: 08:46:23 INFO - { 08:46:23 INFO - "project": "", 08:46:23 INFO - "product": "firefox", 08:46:23 INFO - "who": "philringnalda@gmail.com", 08:46:23 INFO - "installer_path": "public/build/target.tar.bz2", 08:46:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 08:46:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:46:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 08:46:23 INFO - "stage_platform": "linux64-stylo", 08:46:23 INFO - "basedir": "/builds/slave/test", 08:46:23 INFO - "buildnumber": 16, 08:46:23 INFO - "platform": "ubuntu64_hw_stylo", 08:46:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:46:23 INFO - "slavebuilddir": "test", 08:46:23 INFO - "taskId": "Bm-F8GuaTBmdJhQI6vZHJQ", 08:46:23 INFO - "branch": "mozilla-central", 08:46:23 INFO - "script_repo_revision": "production", 08:46:23 INFO - "revision": "19e555dcd7e28ffae4440fb2220f1671cb81d6de", 08:46:23 INFO - "slavename": "talos-linux64-ix-001", 08:46:23 INFO - "repo_path": "mozilla-central" 08:46:23 INFO - } 08:46:23 INFO - Finding installer, test and symbols from parent task. 08:46:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bm-F8GuaTBmdJhQI6vZHJQ'}, attempt #1 08:46:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bm-F8GuaTBmdJhQI6vZHJQ'}, attempt #1 08:46:24 INFO - Task dependencies: OaV4HxZ1TIiM2X3eVMi6rQ 08:46:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ'}, attempt #1 08:46:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2 08:46:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/test_packages.json 08:46:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.crashreporter-symbols.zip 08:46:25 INFO - Running post-action listener: _resource_record_post_action 08:46:25 INFO - [mozharness: 2017-04-07 15:46:25.030335Z] Finished read-buildbot-config step (success) 08:46:25 INFO - [mozharness: 2017-04-07 15:46:25.030552Z] Running download-and-extract step. 08:46:25 INFO - Running pre-action listener: _resource_record_pre_action 08:46:25 INFO - Running main action method: download_and_extract 08:46:25 INFO - mkdir: /builds/slave/test/build/tests 08:46:25 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')]} 08:46:25 INFO - trying https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.test_packages.json 08:46:25 INFO - Downloading https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:46:25 INFO - Downloaded 986 bytes. 08:46:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:46:25 INFO - Using the following test package requirements: 08:46:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:46:25 INFO - u'common': [u'target.common.tests.zip'], 08:46:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:46:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:46:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:46:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:46:25 INFO - u'mozbase': [u'target.common.tests.zip'], 08:46:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:46:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:46:25 INFO - u'web-platform': [u'target.common.tests.zip', 08:46:25 INFO - u'target.web-platform.tests.zip'], 08:46:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:46:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:46:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.common.tests.zip 08:46:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:25 INFO - Fetch https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.common.tests.zip into memory 08:46:26 INFO - Expected file size: 58243864 08:46:26 INFO - Obtained file size: 58243864 08:46:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:46:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.common.tests.zip 08:46:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:36 INFO - Fetch https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.common.tests.zip into memory 08:46:37 INFO - Expected file size: 58243864 08:46:37 INFO - Obtained file size: 58243864 08:46:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.talos.tests.zip 08:46:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:46:48 INFO - Fetch https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.talos.tests.zip into memory 08:46:48 INFO - Expected file size: 14404138 08:46:48 INFO - Obtained file size: 14404138 08:46: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')]} 08:46:49 INFO - trying https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2 08:46:49 INFO - Downloading https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:46:50 INFO - Downloaded 59149691 bytes. 08:46:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2 08:46:50 INFO - mkdir: /builds/slave/test/properties 08:46:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:50 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:50 INFO - Contents: 08:46:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2 08:46:50 INFO - Running post-action listener: _resource_record_post_action 08:46:50 INFO - Running post-action listener: set_extra_try_arguments 08:46:50 INFO - [mozharness: 2017-04-07 15:46:50.246635Z] Finished download-and-extract step (success) 08:46:50 INFO - [mozharness: 2017-04-07 15:46:50.246731Z] Running populate-webroot step. 08:46:50 INFO - Running pre-action listener: _resource_record_pre_action 08:46:50 INFO - Running main action method: populate_webroot 08:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:50 INFO - '--tppagecycles', 08:46:50 INFO - '7'], 08:46:50 INFO - 'tests': ['tsvgm']}}, 08:46:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:46:50 INFO - 'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:46:50 INFO - 'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['damp', 'tps']}, 08:46:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:46:50 INFO - 'tests': ['damp', 'tps']}, 08:46:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['dromaeo_dom']}, 08:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['basic_compositor_video']}, 08:46:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:46:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['a11yr', 08:46:50 INFO - 'ts_paint', 08:46:50 INFO - 'tpaint', 08:46:50 INFO - 'sessionrestore', 08:46:50 INFO - 'sessionrestore_no_auto_restore', 08:46:50 INFO - 'tabpaint']}, 08:46:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:50 INFO - 'ts_paint', 08:46:50 INFO - 'tpaint', 08:46:50 INFO - 'sessionrestore', 08:46:50 INFO - 'sessionrestore_no_auto_restore', 08:46:50 INFO - 'tabpaint']}, 08:46:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:50 INFO - 'ts_paint', 08:46:50 INFO - 'tpaint', 08:46:50 INFO - 'sessionrestore', 08:46:50 INFO - 'sessionrestore_no_auto_restore', 08:46:50 INFO - 'tabpaint']}, 08:46:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:50 INFO - 'ts_paint', 08:46:50 INFO - 'tpaint', 08:46:50 INFO - 'sessionrestore', 08:46:50 INFO - 'sessionrestore_no_auto_restore', 08:46:50 INFO - 'tabpaint']}, 08:46:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['a11yr', 08:46:50 INFO - 'ts_paint', 08:46:50 INFO - 'tpaint', 08:46:50 INFO - 'sessionrestore', 08:46:50 INFO - 'sessionrestore_no_auto_restore', 08:46:50 INFO - 'tabpaint']}, 08:46:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['a11yr', 08:46:50 INFO - 'ts_paint', 08:46:50 INFO - 'tpaint', 08:46:50 INFO - 'sessionrestore', 08:46:50 INFO - 'sessionrestore_no_auto_restore', 08:46:50 INFO - 'tabpaint']}, 08:46:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['tsvgx', 08:46:50 INFO - 'tsvgr_opacity', 08:46:50 INFO - 'tart', 08:46:50 INFO - 'tscrollx', 08:46:50 INFO - 'cart', 08:46:50 INFO - 'tsvg_static']}, 08:46:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:50 INFO - 'tsvgr_opacity', 08:46:50 INFO - 'tart', 08:46:50 INFO - 'tscrollx', 08:46:50 INFO - 'cart', 08:46:50 INFO - 'tsvg_static']}, 08:46:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:46:50 INFO - 'talos_options': ['--disable-e10s'], 08:46:50 INFO - 'tests': ['tp5o']}, 08:46:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:46:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:46:50 INFO - 'talos_options': ['--disable-e10s', 08:46:50 INFO - '--xperf_path', 08:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:50 INFO - 'tests': ['tp5n']}, 08:46:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:46:50 INFO - 'talos_options': ['--xperf_path', 08:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:50 INFO - 'tests': ['tp5n']}}, 08:46:50 INFO - 'talos.zip': {'path': '', 08:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:50 INFO - Running post-action listener: _resource_record_post_action 08:46:50 INFO - [mozharness: 2017-04-07 15:46:50.259888Z] Finished populate-webroot step (success) 08:46:50 INFO - [mozharness: 2017-04-07 15:46:50.259977Z] Running create-virtualenv step. 08:46:50 INFO - Running pre-action listener: _resource_record_pre_action 08:46:50 INFO - Running main action method: create_virtualenv 08:46:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:50 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 08:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:50 INFO - Using real prefix '/usr' 08:46:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:52 INFO - Installing pip.................done. 08:46:52 INFO - Return code: 0 08:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:46:53 INFO - Reading from file tmpfile_stdout 08:46:53 INFO - Output received: 08:46:53 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) 08:46:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:53 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')]} 08:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:53 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')]} 08:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:53 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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:46:53 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 08:46:53 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 08:46:53 INFO - Using env: {'DISPLAY': ':0', 08:46:53 INFO - 'HOME': '/home/cltbld', 08:46:53 INFO - 'LANG': 'en_US.UTF-8', 08:46:53 INFO - 'LANGUAGE': 'en_US:en', 08:46:53 INFO - 'LOGNAME': 'cltbld', 08:46:53 INFO - 'MAIL': '/var/mail/cltbld', 08:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:53 INFO - 'MOZ_NO_REMOTE': '1', 08:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:53 INFO - 'NO_EM_RESTART': '1', 08:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:53 INFO - 'PWD': '/builds/slave/test', 08:46:53 INFO - 'SHELL': '/bin/bash', 08:46:53 INFO - 'SHLVL': '1', 08:46:53 INFO - 'TERM': 'linux', 08:46:53 INFO - 'TMOUT': '86400', 08:46:53 INFO - 'USER': 'cltbld', 08:46:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:53 INFO - '_': '/tools/buildbot/bin/python'} 08:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:53 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 08:46:53 INFO - Cleaning up... 08:46:53 INFO - Return code: 0 08:46:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46:53 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')]} 08:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:53 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')]} 08:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:53 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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:46:53 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 08:46:53 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 08:46:53 INFO - Using env: {'DISPLAY': ':0', 08:46:53 INFO - 'HOME': '/home/cltbld', 08:46:53 INFO - 'LANG': 'en_US.UTF-8', 08:46:53 INFO - 'LANGUAGE': 'en_US:en', 08:46:53 INFO - 'LOGNAME': 'cltbld', 08:46:53 INFO - 'MAIL': '/var/mail/cltbld', 08:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:53 INFO - 'MOZ_NO_REMOTE': '1', 08:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:53 INFO - 'NO_EM_RESTART': '1', 08:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:53 INFO - 'PWD': '/builds/slave/test', 08:46:53 INFO - 'SHELL': '/bin/bash', 08:46:53 INFO - 'SHLVL': '1', 08:46:53 INFO - 'TERM': 'linux', 08:46:53 INFO - 'TMOUT': '86400', 08:46:53 INFO - 'USER': 'cltbld', 08:46:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:53 INFO - '_': '/tools/buildbot/bin/python'} 08:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:53 INFO - Downloading/unpacking psutil>=3.1.1 08:46:53 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 08:46:53 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 08:46:53 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 08:46:53 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 08:46:53 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 08:46:53 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 08:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:55 INFO - Installing collected packages: psutil 08:46:55 INFO - Running setup.py install for psutil 08:46:55 INFO - building 'psutil._psutil_linux' extension 08:46:55 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 08:46:55 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 08:46:55 INFO - building 'psutil._psutil_posix' extension 08:46:55 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 08:46:56 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 08:46:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:56 INFO - Successfully installed psutil 08:46:56 INFO - Cleaning up... 08:46:56 INFO - Return code: 0 08:46:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46:56 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')]} 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 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')]} 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:46:56 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 08:46:56 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 08:46:56 INFO - Using env: {'DISPLAY': ':0', 08:46:56 INFO - 'HOME': '/home/cltbld', 08:46:56 INFO - 'LANG': 'en_US.UTF-8', 08:46:56 INFO - 'LANGUAGE': 'en_US:en', 08:46:56 INFO - 'LOGNAME': 'cltbld', 08:46:56 INFO - 'MAIL': '/var/mail/cltbld', 08:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:56 INFO - 'MOZ_NO_REMOTE': '1', 08:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:56 INFO - 'NO_EM_RESTART': '1', 08:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:56 INFO - 'PWD': '/builds/slave/test', 08:46:56 INFO - 'SHELL': '/bin/bash', 08:46:56 INFO - 'SHLVL': '1', 08:46:56 INFO - 'TERM': 'linux', 08:46:56 INFO - 'TMOUT': '86400', 08:46:56 INFO - 'USER': 'cltbld', 08:46:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:56 INFO - '_': '/tools/buildbot/bin/python'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46:56 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 08:46:56 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 08:46:56 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 08:46:56 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 08:46:56 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 08:46:56 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 08:46:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:46:58 INFO - Installing collected packages: mozsystemmonitor 08:46:58 INFO - Running setup.py install for mozsystemmonitor 08:46:58 INFO - Successfully installed mozsystemmonitor 08:46:58 INFO - Cleaning up... 08:46:58 INFO - Return code: 0 08:46:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:46:58 INFO - Using env: {'DISPLAY': ':0', 08:46:58 INFO - 'HOME': '/home/cltbld', 08:46:58 INFO - 'LANG': 'en_US.UTF-8', 08:46:58 INFO - 'LANGUAGE': 'en_US:en', 08:46:58 INFO - 'LOGNAME': 'cltbld', 08:46:58 INFO - 'MAIL': '/var/mail/cltbld', 08:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:58 INFO - 'MOZ_NO_REMOTE': '1', 08:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:58 INFO - 'NO_EM_RESTART': '1', 08:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:58 INFO - 'PWD': '/builds/slave/test', 08:46:58 INFO - 'SHELL': '/bin/bash', 08:46:58 INFO - 'SHLVL': '1', 08:46:58 INFO - 'TERM': 'linux', 08:46:58 INFO - 'TMOUT': '86400', 08:46:58 INFO - 'USER': 'cltbld', 08:46:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:58 INFO - '_': '/tools/buildbot/bin/python'} 08:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:58 INFO - Downloading/unpacking jsonschema==2.5.1 08:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:47:00 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 08:47:00 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 08:47:00 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 08:47:00 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 08:47:00 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 08:47:00 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 08:47:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:01 INFO - warning: no files found matching '*.txt' 08:47:01 INFO - no previously-included directories found matching 'build' 08:47:01 INFO - no previously-included directories found matching 'dist' 08:47:01 INFO - no previously-included directories found matching '.git*' 08:47:01 INFO - Installing collected packages: jsonschema, functools32 08:47:01 INFO - Running setup.py install for functools32 08:47:01 INFO - warning: no files found matching '*.txt' 08:47:01 INFO - no previously-included directories found matching 'build' 08:47:01 INFO - no previously-included directories found matching 'dist' 08:47:01 INFO - no previously-included directories found matching '.git*' 08:47:01 INFO - Successfully installed jsonschema functools32 08:47:01 INFO - Cleaning up... 08:47:01 INFO - Return code: 0 08:47:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:47:01 INFO - Using env: {'DISPLAY': ':0', 08:47:01 INFO - 'HOME': '/home/cltbld', 08:47:01 INFO - 'LANG': 'en_US.UTF-8', 08:47:01 INFO - 'LANGUAGE': 'en_US:en', 08:47:01 INFO - 'LOGNAME': 'cltbld', 08:47:01 INFO - 'MAIL': '/var/mail/cltbld', 08:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:01 INFO - 'MOZ_NO_REMOTE': '1', 08:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:01 INFO - 'NO_EM_RESTART': '1', 08:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:01 INFO - 'PWD': '/builds/slave/test', 08:47:01 INFO - 'SHELL': '/bin/bash', 08:47:01 INFO - 'SHLVL': '1', 08:47:01 INFO - 'TERM': 'linux', 08:47:01 INFO - 'TMOUT': '86400', 08:47:01 INFO - 'USER': 'cltbld', 08:47:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:01 INFO - '_': '/tools/buildbot/bin/python'} 08:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:47:01 INFO - Cleaning up... 08:47:01 INFO - Return code: 0 08:47:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:47:01 INFO - Using env: {'DISPLAY': ':0', 08:47:01 INFO - 'HOME': '/home/cltbld', 08:47:01 INFO - 'LANG': 'en_US.UTF-8', 08:47:01 INFO - 'LANGUAGE': 'en_US:en', 08:47:01 INFO - 'LOGNAME': 'cltbld', 08:47:01 INFO - 'MAIL': '/var/mail/cltbld', 08:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:01 INFO - 'MOZ_NO_REMOTE': '1', 08:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:01 INFO - 'NO_EM_RESTART': '1', 08:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:01 INFO - 'PWD': '/builds/slave/test', 08:47:01 INFO - 'SHELL': '/bin/bash', 08:47:01 INFO - 'SHLVL': '1', 08:47:01 INFO - 'TERM': 'linux', 08:47:01 INFO - 'TMOUT': '86400', 08:47:01 INFO - 'USER': 'cltbld', 08:47:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:01 INFO - '_': '/tools/buildbot/bin/python'} 08:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:04 INFO - Downloading docopt-0.6.1.tar.gz 08:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:04 INFO - Running setup.py install for blobuploader 08:47:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:04 INFO - Running setup.py install for requests 08:47:05 INFO - Running setup.py install for docopt 08:47:05 INFO - Successfully installed blobuploader requests docopt 08:47:05 INFO - Cleaning up... 08:47:05 INFO - Return code: 0 08:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:47:05 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 08:47:05 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 08:47:05 INFO - Using env: {'DISPLAY': ':0', 08:47:05 INFO - 'HOME': '/home/cltbld', 08:47:05 INFO - 'LANG': 'en_US.UTF-8', 08:47:05 INFO - 'LANGUAGE': 'en_US:en', 08:47:05 INFO - 'LOGNAME': 'cltbld', 08:47:05 INFO - 'MAIL': '/var/mail/cltbld', 08:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:05 INFO - 'MOZ_NO_REMOTE': '1', 08:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:05 INFO - 'NO_EM_RESTART': '1', 08:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:05 INFO - 'PWD': '/builds/slave/test', 08:47:05 INFO - 'SHELL': '/bin/bash', 08:47:05 INFO - 'SHLVL': '1', 08:47:05 INFO - 'TERM': 'linux', 08:47:05 INFO - 'TMOUT': '86400', 08:47:05 INFO - 'USER': 'cltbld', 08:47:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:05 INFO - '_': '/tools/buildbot/bin/python'} 08:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:05 INFO - Running setup.py (path:/tmp/pip-cgREZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:05 INFO - Running setup.py (path:/tmp/pip-kXwr1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:05 INFO - Running setup.py (path:/tmp/pip-Ubm6rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:05 INFO - Running setup.py (path:/tmp/pip-IdIoxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:05 INFO - Running setup.py (path:/tmp/pip-kNCHnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:05 INFO - Running setup.py (path:/tmp/pip-0P774F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:05 INFO - Running setup.py (path:/tmp/pip-KPYE6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:05 INFO - Running setup.py (path:/tmp/pip-eCKLYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:06 INFO - Running setup.py (path:/tmp/pip-A80SpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:06 INFO - Running setup.py (path:/tmp/pip-KPxDmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:06 INFO - Running setup.py (path:/tmp/pip-gcj820-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:06 INFO - Running setup.py (path:/tmp/pip-c6zelc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:06 INFO - Running setup.py (path:/tmp/pip-lMimFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:06 INFO - Running setup.py (path:/tmp/pip-XQHUgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:06 INFO - Running setup.py (path:/tmp/pip-DvN5Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:06 INFO - Running setup.py (path:/tmp/pip-Imgr5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:06 INFO - Running setup.py (path:/tmp/pip-H03Ezk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:06 INFO - Running setup.py install for manifestparser 08:47:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Running setup.py install for mozcrash 08:47:06 INFO - Running setup.py install for mozdebug 08:47:06 INFO - Running setup.py install for mozdevice 08:47:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozfile 08:47:07 INFO - Running setup.py install for mozhttpd 08:47:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozinfo 08:47:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozInstall 08:47:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozleak 08:47:07 INFO - Running setup.py install for mozlog 08:47:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for moznetwork 08:47:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozprocess 08:47:07 INFO - Running setup.py install for mozprofile 08:47:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Running setup.py install for mozrunner 08:47:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Running setup.py install for mozscreenshot 08:47:08 INFO - Running setup.py install for moztest 08:47:08 INFO - Running setup.py install for mozversion 08:47:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:08 INFO - Cleaning up... 08:47:08 INFO - Return code: 0 08:47:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:08 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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:47:08 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 08:47:08 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 08:47:08 INFO - Using env: {'DISPLAY': ':0', 08:47:08 INFO - 'HOME': '/home/cltbld', 08:47:08 INFO - 'LANG': 'en_US.UTF-8', 08:47:08 INFO - 'LANGUAGE': 'en_US:en', 08:47:08 INFO - 'LOGNAME': 'cltbld', 08:47:08 INFO - 'MAIL': '/var/mail/cltbld', 08:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:08 INFO - 'MOZ_NO_REMOTE': '1', 08:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:08 INFO - 'NO_EM_RESTART': '1', 08:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:08 INFO - 'PWD': '/builds/slave/test', 08:47:08 INFO - 'SHELL': '/bin/bash', 08:47:08 INFO - 'SHLVL': '1', 08:47:08 INFO - 'TERM': 'linux', 08:47:08 INFO - 'TMOUT': '86400', 08:47:08 INFO - 'USER': 'cltbld', 08:47:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:08 INFO - '_': '/tools/buildbot/bin/python'} 08:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:08 INFO - Running setup.py (path:/tmp/pip-_jDmdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:08 INFO - Running setup.py (path:/tmp/pip-qFAcro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:08 INFO - Running setup.py (path:/tmp/pip-o2EDRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:08 INFO - Running setup.py (path:/tmp/pip-58Ls5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:08 INFO - Running setup.py (path:/tmp/pip-Fj8VRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:09 INFO - Running setup.py (path:/tmp/pip-6J8XFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:09 INFO - Running setup.py (path:/tmp/pip-HGwIBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:09 INFO - Running setup.py (path:/tmp/pip-dK7zxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:09 INFO - Running setup.py (path:/tmp/pip-OnandW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:09 INFO - Running setup.py (path:/tmp/pip-UZBotf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:09 INFO - Running setup.py (path:/tmp/pip-1Hc0ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:09 INFO - Running setup.py (path:/tmp/pip-VA8Xnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:09 INFO - Running setup.py (path:/tmp/pip-EcgTk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:09 INFO - Running setup.py (path:/tmp/pip-by9jPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:09 INFO - Running setup.py (path:/tmp/pip-mMTYli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:09 INFO - Running setup.py (path:/tmp/pip-uD5XHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:09 INFO - Running setup.py (path:/tmp/pip-0mVVm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:09 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)) 08:47:09 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)) 08:47:09 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)) 08:47:09 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)) 08:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:12 INFO - Downloading blessings-1.6.tar.gz 08:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:12 INFO - Installing collected packages: blessings 08:47:12 INFO - Running setup.py install for blessings 08:47:12 INFO - Successfully installed blessings 08:47:12 INFO - Cleaning up... 08:47:12 INFO - Return code: 0 08:47:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:12 INFO - Reading from file tmpfile_stdout 08:47:12 INFO - Current package versions: 08:47:12 INFO - argparse == 1.2.1 08:47:12 INFO - blessings == 1.6 08:47:12 INFO - blobuploader == 1.2.4 08:47:12 INFO - docopt == 0.6.1 08:47:12 INFO - functools32 == 3.2.3-2 08:47:12 INFO - jsonschema == 2.5.1 08:47:12 INFO - manifestparser == 1.1 08:47:12 INFO - mozInstall == 1.12 08:47:12 INFO - mozcrash == 1.0 08:47:12 INFO - mozdebug == 0.1 08:47:12 INFO - mozdevice == 0.50 08:47:12 INFO - mozfile == 1.2 08:47:12 INFO - mozhttpd == 0.7 08:47:12 INFO - mozinfo == 0.9 08:47:12 INFO - mozleak == 0.1 08:47:12 INFO - mozlog == 3.4 08:47:12 INFO - moznetwork == 0.27 08:47:12 INFO - mozprocess == 0.25 08:47:12 INFO - mozprofile == 0.28 08:47:12 INFO - mozrunner == 6.13 08:47:12 INFO - mozscreenshot == 0.1 08:47:12 INFO - mozsystemmonitor == 0.3 08:47:12 INFO - moztest == 0.8 08:47:12 INFO - mozversion == 1.4 08:47:12 INFO - psutil == 3.1.1 08:47:12 INFO - requests == 1.2.3 08:47:12 INFO - wsgiref == 0.1.2 08:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:12 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')]} 08:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:12 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')]} 08:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:12 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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:47:12 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 08:47:12 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 08:47:12 INFO - Using env: {'DISPLAY': ':0', 08:47:12 INFO - 'HOME': '/home/cltbld', 08:47:12 INFO - 'LANG': 'en_US.UTF-8', 08:47:12 INFO - 'LANGUAGE': 'en_US:en', 08:47:12 INFO - 'LOGNAME': 'cltbld', 08:47:12 INFO - 'MAIL': '/var/mail/cltbld', 08:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:12 INFO - 'MOZ_NO_REMOTE': '1', 08:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:12 INFO - 'NO_EM_RESTART': '1', 08:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:12 INFO - 'PWD': '/builds/slave/test', 08:47:12 INFO - 'SHELL': '/bin/bash', 08:47:12 INFO - 'SHLVL': '1', 08:47:12 INFO - 'TERM': 'linux', 08:47:12 INFO - 'TMOUT': '86400', 08:47:12 INFO - 'USER': 'cltbld', 08:47:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:12 INFO - '_': '/tools/buildbot/bin/python'} 08:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 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)) 08:47:12 INFO - Cleaning up... 08:47:12 INFO - Return code: 0 08:47:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:12 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')]} 08:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:12 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')]} 08:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:12 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 0x26541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', '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 08:47:12 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 08:47:12 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 08:47:12 INFO - Using env: {'DISPLAY': ':0', 08:47:12 INFO - 'HOME': '/home/cltbld', 08:47:12 INFO - 'LANG': 'en_US.UTF-8', 08:47:12 INFO - 'LANGUAGE': 'en_US:en', 08:47:12 INFO - 'LOGNAME': 'cltbld', 08:47:12 INFO - 'MAIL': '/var/mail/cltbld', 08:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:12 INFO - 'MOZ_NO_REMOTE': '1', 08:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:12 INFO - 'NO_EM_RESTART': '1', 08:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:12 INFO - 'PWD': '/builds/slave/test', 08:47:12 INFO - 'SHELL': '/bin/bash', 08:47:12 INFO - 'SHLVL': '1', 08:47:12 INFO - 'TERM': 'linux', 08:47:12 INFO - 'TMOUT': '86400', 08:47:12 INFO - 'USER': 'cltbld', 08:47:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:12 INFO - '_': '/tools/buildbot/bin/python'} 08:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:47:13 INFO - Cleaning up... 08:47:13 INFO - Return code: 0 08:47:13 INFO - Running post-action listener: _resource_record_post_action 08:47:13 INFO - Running post-action listener: _start_resource_monitoring 08:47:13 INFO - Starting resource monitoring. 08:47:13 INFO - [mozharness: 2017-04-07 15:47:13.139242Z] Finished create-virtualenv step (success) 08:47:13 INFO - [mozharness: 2017-04-07 15:47:13.139761Z] Running install step. 08:47:13 INFO - Running pre-action listener: _resource_record_pre_action 08:47:13 INFO - Running main action method: install 08:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:13 INFO - Reading from file tmpfile_stdout 08:47:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:13 INFO - Reading from file tmpfile_stdout 08:47:13 INFO - Output received: 08:47:13 INFO - Usage: mozinstall [options] installer 08:47:13 INFO - Options: 08:47:13 INFO - -h, --help show this help message and exit 08:47:13 INFO - -d DEST, --destination=DEST 08:47:13 INFO - Directory to install application into. [default: 08:47:13 INFO - "/builds/slave/test"] 08:47:13 INFO - --app=APP Application being installed. [default: firefox] 08:47:13 INFO - mkdir: /builds/slave/test/build/application 08:47:13 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'] 08:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:47:28 INFO - Reading from file tmpfile_stdout 08:47:28 INFO - Output received: 08:47:28 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:28 INFO - Running post-action listener: _resource_record_post_action 08:47:28 INFO - [mozharness: 2017-04-07 15:47:28.559131Z] Finished install step (success) 08:47:28 INFO - [mozharness: 2017-04-07 15:47:28.559405Z] Running run-tests step. 08:47:28 INFO - Running pre-action listener: _resource_record_pre_action 08:47:28 INFO - Running main action method: run_tests 08:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:28 INFO - Python 2.7.3 08:47:28 INFO - Return code: 0 08:47:28 INFO - grabbing minidump binary from tooltool 08:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:28 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 0x28ef400>, '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 0x28f03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f0840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:28 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 08:47:28 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 08:47:28 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 08:47:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:28 INFO - Return code: 0 08:47:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:28 INFO - ENV: RUST_BACKTRACE is now 1 08:47:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:47:28 INFO - Using env: {'DISPLAY': ':0', 08:47:28 INFO - 'HOME': '/home/cltbld', 08:47:28 INFO - 'LANG': 'en_US.UTF-8', 08:47:28 INFO - 'LANGUAGE': 'en_US:en', 08:47:28 INFO - 'LOGNAME': 'cltbld', 08:47:28 INFO - 'MAIL': '/var/mail/cltbld', 08:47:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:28 INFO - 'MOZ_NO_REMOTE': '1', 08:47:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:28 INFO - 'NO_EM_RESTART': '1', 08:47:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:28 INFO - 'PWD': '/builds/slave/test', 08:47:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:28 INFO - 'RUST_BACKTRACE': '1', 08:47:28 INFO - 'SHELL': '/bin/bash', 08:47:28 INFO - 'SHLVL': '1', 08:47:28 INFO - 'TERM': 'linux', 08:47:28 INFO - 'TMOUT': '86400', 08:47:28 INFO - 'USER': 'cltbld', 08:47:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750', 08:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:28 INFO - '_': '/tools/buildbot/bin/python'} 08:47:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:47:28 INFO - mozversion application_buildid: 20170407145947 08:47:28 INFO - mozversion application_changeset: 19e555dcd7e28ffae4440fb2220f1671cb81d6de 08:47:28 INFO - mozversion application_display_name: Nightly 08:47:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:28 INFO - mozversion application_name: Firefox 08:47:28 INFO - mozversion application_remotingname: firefox 08:47:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:28 INFO - mozversion application_vendor: Mozilla 08:47:28 INFO - mozversion application_version: 55.0a1 08:47:28 INFO - mozversion platform_buildid: 20170407145947 08:47:28 INFO - mozversion platform_changeset: 19e555dcd7e28ffae4440fb2220f1671cb81d6de 08:47:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:28 INFO - mozversion platform_version: 55.0a1 08:47:28 INFO - using testdate: 1491580048 08:47:28 INFO - actual date: 1491580048 08:47:28 INFO - starting webserver on 'localhost:41040' 08:47:28 INFO - SUITE-START | Running 2 tests 08:47:28 INFO - TEST-START | dromaeo_css 08:47:28 INFO - operating with platform_type : linux_ 08:47:28 INFO - Initialising browser for dromaeo_css test... 08:47:28 INFO - TEST-INFO | started process 5804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCm0fqY/profile http://localhost:41040/getInfo.html) 08:47:33 INFO - PID 5804 | __metrics Screen width/height:1600/1200 08:47:33 INFO - PID 5804 | colorDepth:24 08:47:33 INFO - PID 5804 | Browser inner width/height: 1024/697 08:47:33 INFO - PID 5804 | __metrics 08:47:34 INFO - PID 5804 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:47:34 INFO - PID 5804 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:35 INFO - TEST-INFO | 5804: exit 0 08:47:35 INFO - Browser initialized. 08:47:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:35 INFO - TEST-INFO | started process 5902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCm0fqY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:47 INFO - PID 5902 | RSS: Main: 172466176 08:47:47 INFO - PID 5902 | 08:50:54 INFO - PID 5902 | Cycle 1(1): loaded http://localhost:41040/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41040/tests/dromaeo/cssquery-ext.html) 08:50:56 INFO - PID 5902 | RSS: Main: 317931520 08:50:56 INFO - PID 5902 | 08:52:36 INFO - PID 5902 | ************************* 08:52:36 INFO - PID 5902 | A coding exception was thrown and uncaught in a Task. 08:52:36 INFO - PID 5902 | 08:52:36 ERROR - PID 5902 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:52:36 INFO - PID 5902 | Full stack: 08:52:36 INFO - PID 5902 | ************************* 08:52:36 INFO - PID 5902 | ************************* 08:52:36 INFO - PID 5902 | A coding exception was thrown and uncaught in a Task. 08:52:36 INFO - PID 5902 | 08:52:36 ERROR - PID 5902 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:52:36 INFO - PID 5902 | Full stack: 08:52:36 INFO - PID 5902 | ************************* 08:52:36 INFO - PID 5902 | ************************* 08:52:36 INFO - PID 5902 | A coding exception was thrown and uncaught in a Task. 08:52:36 INFO - PID 5902 | 08:52:36 ERROR - PID 5902 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:52:36 INFO - PID 5902 | Full stack: 08:52:36 INFO - PID 5902 | ************************* 08:52:36 INFO - PID 5902 | ************************* 08:52:36 INFO - PID 5902 | A coding exception was thrown and uncaught in a Task. 08:52:36 INFO - PID 5902 | 08:52:36 ERROR - PID 5902 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:52:36 INFO - PID 5902 | Full stack: 08:52:36 INFO - PID 5902 | ************************* 08:53:58 INFO - PID 5902 | Cycle 1(1): loaded http://localhost:41040/tests/dromaeo/cssquery-ext.html (next: http://localhost:41040/tests/dromaeo/cssquery-jquery.html) 08:53:59 INFO - PID 5902 | RSS: Main: 250834944 08:53:59 INFO - PID 5902 | 08:57:01 INFO - PID 5902 | Cycle 1(1): loaded http://localhost:41040/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41040/tests/dromaeo/cssquery-mootools.html) 08:57:02 INFO - PID 5902 | RSS: Main: 203481088 08:57:02 INFO - PID 5902 | 09:00:04 INFO - PID 5902 | Cycle 1(1): loaded http://localhost:41040/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41040/tests/dromaeo/cssquery-prototype.html) 09:00:04 INFO - PID 5902 | RSS: Main: 246992896 09:00:04 INFO - PID 5902 | 09:03:08 INFO - PID 5902 | Cycle 1(1): loaded http://localhost:41040/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41040/tests/dromaeo/cssquery-yui.html) 09:03:08 INFO - PID 5902 | RSS: Main: 215539712 09:03:08 INFO - PID 5902 | 09:06:11 INFO - PID 5902 | Cycle 1(1): loaded http://localhost:41040/tests/dromaeo/cssquery-yui.html (next: http://localhost:41040/tests/dromaeo/cssquery-dojo.html) 09:06:12 INFO - PID 5902 | RSS: Main: 299712512 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | __start_tp_report 09:06:12 INFO - PID 5902 | _x_x_mozilla_page_load 09:06:12 INFO - PID 5902 | _x_x_mozilla_page_load_details 09:06:12 INFO - PID 5902 | |i|pagename|runs| 09:06:12 INFO - PID 5902 | |0;dojo.html;2697.662792150981;2744.9039283625075;2770.2658795419215;2778.485980093683;2800.719928007199;5107.540321371076;5228.764705588248;5234.973825130874;5260.184671375933;5330.706811125387;5204.271402003723;5225.817096401626;5237.292965449673;5245.396779370373;5281.70950597717;4382.276924307485;4636.744979026161;4738.928916066262;4777.952220477803;4785.688930219525;4687.90624187516;4707.388039554853;4735.171345014626;4742.786574604133;4787.329773831666;4572.428446444194;4589.908201835945;4620.2607582786595;4629.027904140101;4669.042846216517;4639.837605683785;4656.278276867091;4659.930101048487;4713.175194341011;4733.763311834429;4587.931181032287;4609.262517997105;4630.907381852344;4646.605038571725;4657.2315567931255;5001.949980500185;5054.469280725544;5168.405633352138;5171.0692075426405;5195.558377537914;5583.5254003409755;5663.830085097454;5686.232358631614;5704.315482142128;5704.71476426177;5756.280464941882;5760.452756988079;5768.596198266123;5770.913436298459;5776.364599894008;5281.630285880028;5292.497212764782;5293.920591191135;5299.099153143975;5299.788008479656;5693.060644993612;5721.828345149652;5821.068629019336;5834.358220595731;5844.327902291206;5535.197396377584;5548.056830338852;5555.111182210827;5605.355384130796;5620.3255609326325;5702.572307076985;5705.7147142643535;5707;5707.914381284284;5735.741891614887;5597.720113994284;5618.297712785902;5642.238297829823;5657.405972372924;5673.943260567342;5511.200875872976;5524.972375138099;5584.301962254718;5586.944130558642;5626.043572592587;4852.660313778002;4860.441049279308;4864.1001414737675;4898.755062246873;4904.43598986114;4069.9214708102377;4121.4848143982;4121.567235440296;4138.896527586834;4152.065785198306;4658.301254811738;4731.550502702238;4774.832880849223;4796.880077998078;4804.95195048052;5684.403137670568;5699.629524081004;5707;5728.341240757283;5753.8561535961935;4756.9762151189025;4785.736784476818;4795.136875362398;4803.375561177025;4841.007593443335;4958.8760280993265;5104.617153713486;5110.156824124052;5116.718580478109;5120.692758434506;5162.5095615916425;5185.611079169002;5251.553617942518;5262.500062494057;5266.605004624592;5667.773289068391;5688.232088667977;5689.943100568941;5697.287839020122;5697.601167918372;5244.187150991603;5249.921251181312;5249.947500525099;5257.185136303879;5305.389880163831;5483.862903427446;5527.806526771544;5529.281193444826;5531.861703457445;5532.778688852401;5625.212470254086;5645.237892884408;5687.289088863892;5692.800751973661;5693.345265294544;5375.892482150413;5386.48828361305;5397.541208997279;5435.510804027656;5465.426130256265;5426;5474.507294343528;5483.259759932358;5498.532624726943;5509.834704958857;5446.782128714807;5470.8905821882545;5472.808451704172;5476.205950137128;5476.753546090516;5397.244385785914;5464.562834973272;5466.125419932791;5537.778488860562;5542.722863856871;5418.756155973069;5432.837014889559;5440.918386224131;5443.564514838724;5488.17677348401 09:06:12 INFO - PID 5902 | |1;ext.html;662.1987395251745;724.7246046502328;737.9483436159468;1066.8026415113209;1068.9305195162315;26329.341766455826;27077.18768436945;27079.593806092926;27080.59379109315;27091.593626095626;31769.68230317696;32560.837195813987;32577.348453030925;32583.185420364443;32605.67394326056;7068.964655176717;7205.639718014078;7216.061911951439;7216.097987751531;7220.783376498687;5516.310461192351;5669.376368599451;7094.751683691072;7206.531575447605;7207.20720720723;6802.931970680279;7262.128544574632;7264.346208841203;7271.309225623558;7272.090988626422;7252.564846109224;7289.708411663527;7306.342429181346;7309.415246780245;7323.780286591411;5371.355437347504;5496.340439147288;7134.143902731706;7205.315495027964;7227.566346019255;29541;30194.245143871358;30205.848970755007;30277.545836812245;30301.545476817864;2777.5555911054335;2816.1973837456226;2816.605675205473;2818.7040360762235;2819.84490853003;23514.882425587763;23719.644205336936;23726.762732372626;23751.406214844596;23838.284851454486;2710.254679963026;2712.0914493644655;2733.7676297514736;2734.1387462949106;2763.322985868455;137505;137619.31190344083;137625;137696;137716.31141844226;39940.60059399427;39962.20075598472;40048.59951400448;40069;40082.19835603271;41818.79090604527;41935.790321048196;41982.79008604999;42000;42087;12027.699307517381;12076.577319793765;12091.093168012434;12094.637160885011;12105.818412723816;9682.515874206403;9687.079727425884;9691.9030809691;9701.175400091071;9707.6116955321;10357.689269321781;10498.317609355367;10508.106810921005;11154.163437742201;11663.650090497298;4533.478649955231;5186.299849520266;5485.561155107582;5534.335879694382;5571.860703482445;881.8809460722848;902.0663613160348;904.263025634106;923.8013827027087;941.1670671455811;20838.27066052681;21648.24231151902;21689.67465488019;21814.56370872574;22188.556228875656;976.1507488485064;987.4717026390847;992.2359782967219;995.0397866059143;1010.282699283517;10924.50839712199;10949.397783121845;11180;11224.887751122547;11273.492692828842;204165;206504;206596;206777;207228;39132.804335978704;39345.80327098403;39352.409713854315;39460;39517;1234.734532075608;1250.581055346451;1265.025930033887;1271.053065466215;1273.9808902866464;19025.107836537485;19126.23495060238;19546.90226548858;20594.176232950515;20685.586288273847;28599;28688.713112868605;28702.712972870006;28728.569071464364;28730.71269287364;177069;178504.10747946176;178624;178730.10634947263;179095;27753.72246277592;28170.85914570414;28517.857410712815;28634;28675.28311792222;26142.86928565345;32749.508757369134;32754.34491310113;34166.82916585401;34209.14477137992;24954;26755.19734407971;27122.457550848478;27150.321241969108;27830.304242393293;26258;26503.33741656474;26583.867080664473;26767.866160669073;27624.72375276302;29897.252568685955;29923;29952.25119372033;29964.25089372696;30272.69727302787;25893.6115958257;26230.86884565565;26363;26464.0737574184;26605.334866628487;20556;22122.33632991013;22203.888980554995;22360.440988975406;22538.436539085997 09:06:12 INFO - PID 5902 | |2;jquery.html;395.7526545908807;397.9104701442176;414.5253684531211;420.3526569083611;425.67861264745113;17170.742438863428;18146.18342174602;18768.906155469205;18936.71594926077;18954.62090758186;18654.53363665909;18754;18873.24507019721;19120.521986950334;19265.518362040955;5308.469153084699;5487.972560137214;5529.419410961851;5541;5749.166370876221;5490.780368785264;5530.115181570949;5540.9168862467095;5541.307336582927;5550.028744969634;5441.183822426648;5485;5628.352739434956;5644.209810626516;5659.179418984245;5540.944590554083;5576.107822748361;5614.831555053355;5624.775008999635;5638.126090455966;4849.5635392814465;4886.047220791947;4888.120138375091;4892.3884514435695;4893.6329775266995;22238;22785.20251791179;22819.42951426211;22918.54162916749;22981.19565815205;1605.1252067623057;1669.4741156535651;1680.1095419427722;1682.5793551612096;1684.6630673865277;14843.109413435228;15125.773113403307;15194.316255768517;15234.162121083336;15399.613059975722;2077.0860821238757;2080.3966849613594;2104.5264815416563;2118.8622739522034;2123.6283650361124;69872;88136.55931720365;88581;89172;89346;17829.554261143316;17937;18353.81646183548;18395.72406413905;19100.33148839784;33234;33412.498812517835;33438.832805836304;33590;33965.41466901986;8702.738917832476;8762.299016078698;8853.247473964657;8895.955520222487;9162.450252984841;6969.337912898267;7067.176298174109;7188.640567971581;7274.0543729315905;7335.853282934311;9124.167849503092;9459.337846350689;9511.239100871913;9542.475163866055;9685.111403276434;3659.432787917877;3817.5790377663784;3836.366999445116;3864.787436691009;3949.7827619481204;830.8712149616819;840.4201101240125;879.5382424227204;883.823235352932;888.4180861535575;16590.917045414695;16670.749203905365;16711.498655040366;16715.832841671672;17395.304187832597;885.6545947080643;888.546841111038;896.8296023755465;898.8651702244584;905.248643625789;8939.155618805109;8982.775430614287;9334.439933604006;9338.48638324885;9372.34393592442;485326;485822;490565;499413;500678;90502;90596.54701726449;90804.54597727102;91078;94149;1086.6739978006724;1092.2408925796494;1114.0641860836936;1121.6466812953893;1121.9831702524468;14149.151050936976;14284.285785710881;14401.135931844123;14441.927790360982;14983.550493485212;39641.79939367527;41162.79418602888;41472.792636036625;41807.37288940608;42598.78700606477;53227.467725322254;53914.46085539251;54333.45666543284;55868.16197757118;55892.72053639706;7157.212706602374;7305.1233851938105;7370.6314684266645;7376.594287314035;7571.842025022842;10900.563977440814;11293.37886416255;11488.885111148782;11561.248518846249;11917.821232681343;9978.351407158512;10047.899521004696;10151.7462063449;10431.791364172826;10461.581536738446;9786.46174460383;9880;9927.702168934944;10020.849687254842;10029.348092373972;9726;9784.119429251117;9982.550785214828;10081.647142349982;10480.266381353233;7488.138864030706;7768.650410731418;7769.145394006542;7769.689212431439;7869.213078692314;9294.395864268801;9740;9824.852627210455;9837.311388202757;10095.192384609361 09:06:12 INFO - PID 5902 | |3;mootools.html;1203.7833190025794;1341.926194059327;1347.8449978252497;1350.1426594112738;1364.0519838712098;10009.699709008732;10426.322289051226;10449.738756531091;10470.52882620282;10498.895011049897;9981.700548983525;10369.429681367521;10392.844107338376;10409.271351005433;10420.114290285335;2270.693456383388;2310.260716570698;2310.89600967956;2311.2835021143414;2312.3294244669028;1848.7319338695881;2136.4979229880964;2203.8126759225406;2216.8669879807185;2236.5303286309895;1918.2806447582157;2233.3858188997992;2303.6544518322303;2312.8843557822124;2314.1206341590173;2163.0915015693445;2163.242864997246;2167.2847960173103;2167.3606286145546;2167.3822960456196;2193.5393567350716;2226.7327920649464;2232.0402227042364;2236.5974124657555;2239.0372139979804;10067.496625168713;10251.84622230667;10276.640317588848;10279.331843430227;10281.383117013003;5729.054705973509;5896.027155519334;5903.26209223847;5911.024680927685;5928.40715928408;3151.401233765577;3362.2098806780386;3366.646502117291;3368.9326213475592;3374.9156271093175;1000.0399616368295;1003;1012.8885822559513;1043.0925095167177;1048.0096308988009;14483.927580362137;14525.78211326831;14546.854531454655;14574.562763117123;14605.92697036508;4722.197226471508;4824.107540105092;4980.90038199234;5018.573421259161;5066.9746651266505;10926.453677316262;10929.125669946385;10940.070094041936;10940.56237750481;10970.122390208764;5816.47651711348;5822.446867547576;5825;5827.24245848037;5831.562632802556;5346.946530534645;5358.062339090644;5447;5457.918131228034;5516.862078448071;3834.884953451345;3919.5492518360184;3929.8428062877165;3966.2464131814863;4046.59534046593;1148.62095508482;1151.631477927072;1159.4608507044265;1168.5559487394735;1175.9764804703857;703.3283214530112;704.9224585295614;718.4862823081522;725.1551941987631;745.3217572009445;5279.736013199325;5324.946750532445;5402.108652072364;5450;5626.521745651584;543.8993786149575;559.8040685759952;565.2171742137169;570.3925319534683;573.2519062623317;3299.1752061984503;3451.3442445935193;3463.8960831175104;3465.9306813864087;3503.2993401319836;13114.672133196746;13650.180989140683;13878.4448622056;13884.58346249614;13902.16587004783;13365.131266467648;13672.179669219879;13758.243296618582;13758.587242382744;13760.862391376158;9571.899231588317;9623.951880240695;9725.465099419458;9797.31418800677;9799.167070799062;5451.536619387396;5480.287562616834;5501.779928802963;5625.240592519957;5724.055530837365;11947.641570752892;12001.1599188056;12115.575954841539;12163.087768417581;12336.321502317458;12439;12466.563670271496;12513.249205047363;12537.93731031339;12588.685282868002;7194.640267986684;7325.706971721072;7326.230745771617;7330.816729581803;7331.010313607595;9182.449053056838;9235.307351948497;9251.76870578241;9292;9350.25197984146;7464.328210461084;7668.661058377248;7674.53952762836;7726.806829829075;7871.370290376871;7803.985481887318;7882.842343153219;7927.60361981887;8024.277814996678;8176.754697359089;6649.335066493505;6756.087928129639;6766.18805743314;6767.763128290486;6775.254721980479;4823.807047718052;5012.373453318335;5126;5146.511081447256;5206.062908676475;4926.901461970812;4953.18272485036;5032.370953630796;5079.034983353151;5135.075686376339 09:06:12 INFO - PID 5902 | |4;prototype.html;337.50218427818953;361.47405524961187;387.40339876590053;390.0521732190777;393.59459756450866;5070.315507406499;5120.1551743962245;5160.542436567499;5267.762950667219;5286.392064912527;5147.408048074472;5152.149895267276;5186.766595503202;5214.504622060907;5233.73831308434;4096.97951510242;4109.979450102745;4121.196366708486;4123.278426275405;4126;3886.727929044968;4010.6390424861756;4017.493439960015;4105.2405305018665;4122.97938510307;4077.3068578341754;4100.2414553307735;4101.384792281152;4104.076582768883;4105.568915263899;4090.6318431341174;4092.611201935826;4093.5292441369324;4098.631123198927;4100.220958017967;3474.6872781449792;3561.821908904544;3641.8543258269638;3710.5732840723394;3729.515163028816;5019.774110165052;5022.824201152978;5053.115704751691;5054.721990290533;5064.733247055628;4829.705889702398;4854.732989685566;4855.101806165871;4859.3682821233015;4862.854114376574;5382.327209098863;5515.834524964257;5561.304836895388;5572.442755724435;5578.442155784389;4176.14389050244;4186.6859985501205;4188.497380314351;4197.097624010852;4202.663786897041;5758.596898217126;5793.8551536211935;5805.564582656276;5813.476787089097;5825.15535247391;4157;4270.765107919095;4312.116016216668;4313.374560688682;4327.37253098299;4057.2899742544937;4361.127774445124;4368.5194628590825;4370.125974805052;4383.561643835655;4657.115148121846;4657.184992626277;4784.378030856036;4798.49615790344;4801.087793319258;5514.36584792754;5536.833894983157;5539.5014448699;5545.112781954868;5567.860803479864;1486.5837565481681;1490.9776353354707;1515.4695856450376;1518.3319339490588;1518.8481151884944;1047.1413440978324;1067.2209287220373;1088.804015277242;1098.3629494892944;1099.2854644481151;4773.260144677581;4792.808287668524;4794.95205047952;4805.27920811881;4821.734804585782;5707.230758464889;5721.713914304268;5742.28221472316;5745.13822926556;5766.942330576724;4597.770111494412;4784.30627559002;4816.783244753994;4819.903601927942;4822.541858523435;2974.2267010577407;3022.5617285493922;3029.6515900671266;3045.695430456981;3054.4349295380425;5230.215467679878;5259.579233661298;5267.789288428497;5310.017646735367;5315.388730296066;5636.323641163087;5880.2943646761805;5891.440313170242;5895.55783316253;5911.586188966817;5286.577073834084;5293.841184764463;5297.841064768063;5308;5310.654807437581;5749.683767392667;5760.337561180518;5771.192033115283;5776.797812076557;5787.045137552257;5405.8107966221;5584;5601.383847776659;5625.156226566048;5627.8593035174445;5275.577953763766;5286.524212820711;5289.285946397187;5293.179557168645;5304.549113325256;3883.650471457582;3961.207758448264;3982.287616325008;4000.3799411091327;4004.4794176756836;5667.894760521659;5676.34722006958;5706.572007099401;5720.427957204412;5731.828045158652;5486.31421072366;5492.505674489315;5497.422770609189;5513.3108361454815;5516.089845175501;5363.678179309254;5479.726013699219;5508.531774799187;5510.283663123768;5524.502794748492;5434.10337294342;5436.320459942507;5444.50999410055;5470.452954704498;5473.726313684379;5530.391656917655;5539.501444869981;5563.193336966198;5567.387587365306;5580.190872323409;5246.580273578181;5352.384475785335;5362.7586758596735;5409.864753381197;5422.810201642924 09:06:12 INFO - PID 5902 | |5;yui.html;675.7297081167533;677.8169894128586;680.7549282258386;703.581369085394;740.9518381305218;12290.078244131691;12636.49454021838;12660.366981650915;12678.429470673831;12686.302253376061;12825.230486170836;12848.67878303043;12939.41772620232;12954.676133096676;12985.285809280485;899.4513346858428;906.1074841281333;920.9585568649427;921.1203300847675;921.1709461484684;951.6241084771511;961.1109723505764;961.7691753979065;961.8653388525577;962.5572236771094;984.9261305402088;989.8812142542905;990.044606954289;990.6582229130938;991.33085167512;979.6962941488126;982.5332966840693;982.7248370456248;983.788485475619;984.0208992052917;725.0031207090251;726.8473620539693;727.6252729844134;727.6434547071949;727.9162896266891;13094.410751516205;13127.40926658293;13143.802842957364;13174.802377964243;13448.394822233024;13320.733585328238;13860.356389353887;13897.513587024405;13931.233782141979;14091.929540352336;10952;11216.49525771334;11305.830412543819;11312.547498100066;11426.657200284004;2842.1757690269797;2843.701411351799;2898.2029941765973;2947.513660246057;2952.1733914503975;61919.38080619181;63262.68368658173;63556;63657.681711591606;64542.03186952246;10093.293469457214;10268.64059757905;10340.172786177087;10355.430451325099;10836.40399778004;20896;20956.580868382545;20961.79038209629;20981.265655702282;20989.79010209909;6274.341194174637;6461.806145815539;6527.5430719849155;6564.4748420127235;6659.334066593399;3329.4672852343992;3377.628460869302;3380.983095084558;3389.4237979543536;3470.6008808986785;3525.7884526928465;3551.8756843510355;3608.386574282378;3612.1872578670113;3612.440071788877;729.2561587181045;733.8935854301203;737.0712901743841;743.9888401673979;747.1184002876549;524.2267655208537;526.2921370756327;532.5579768791894;541.9241306217133;547.075442502178;7668.424868134912;7734.4585878989055;8070.47541909774;8081.797955051171;8277;549.851540084175;550.5980634137102;551.743439300719;554.2794367322465;561.0630247486707;3525.0834782956617;3573.8213089345427;3663.8785380163026;3689.5019172411917;3694.7413681042067;56700.149497757564;58427.123593146134;59550.404495954484;62542;62686.373136268965;51312;51459;51621.22568161481;52179.73910130425;52959.470405296226;46723.5327646726;46849.29726054112;47580.7620961893;47985.5201447988;50037.24944125841;8591.226789588967;8803.427777194462;9056.456612603264;9064.909350906406;9160.862587061332;26191.73808261893;26290.605640915783;26625.866870665523;27073.729262707122;27211;32311.192220194684;32362.83818580892;32512.83743581267;33103;33207.667923320456;10799.514021868878;10851.240413171317;10909.127269818237;11017.724556886142;11579.131565132817;11354.432278386214;11400.201985860911;11947.223430476992;12111.697207569881;12337.938310308391;10714.839277410689;10821.458927053773;10996.65271549087;11163.051140653135;11208.943955280172;10827.350358978172;10932;10949.397783121685;11361.375124367909;11428.371439570903;10892.836607451052;11114.49984750672;11154.553817847196;11188.04901583342;11191.66425007251;7900.4074694397;8110.878336824834;8244.54654993981;8500.659973600987;8546.145385461405;9388.342816002814;9783.217342612716;9791.069848364394;9802.313838031554;9876.40741555509 09:06:12 INFO - PID 5902 | __end_tp_report 09:06:12 INFO - PID 5902 | __start_cc_report 09:06:12 INFO - PID 5902 | _x_x_mozilla_cycle_collect,1436 09:06:12 INFO - PID 5902 | __end_cc_report 09:06:12 INFO - PID 5902 | __startTimestamp1491581172036__endTimestamp 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | ------- Summary: start ------- 09:06:12 INFO - PID 5902 | Number of tests: 6 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | [#0] dojo.html Cycles:165 Average:5171.59 Median:5299.79 stddev:601.93 (11.4%) stddev-sans-first:571.64 09:06:12 INFO - PID 5902 | Values: 2697.7 2744.9 2770.3 2778.5 2800.7 5107.5 5228.8 5235.0 5260.2 5330.7 5204.3 5225.8 5237.3 5245.4 5281.7 4382.3 4636.7 4738.9 4778.0 4785.7 4687.9 4707.4 4735.2 4742.8 4787.3 4572.4 4589.9 4620.3 4629.0 4669.0 4639.8 4656.3 4659.9 4713.2 4733.8 4587.9 4609.3 4630.9 4646.6 4657.2 5001.9 5054.5 5168.4 5171.1 5195.6 5583.5 5663.8 5686.2 5704.3 5704.7 5756.3 5760.5 5768.6 5770.9 5776.4 5281.6 5292.5 5293.9 5299.1 5299.8 5693.1 5721.8 5821.1 5834.4 5844.3 5535.2 5548.1 5555.1 5605.4 5620.3 5702.6 5705.7 5707.0 5707.9 5735.7 5597.7 5618.3 5642.2 5657.4 5673.9 5511.2 5525.0 5584.3 5586.9 5626.0 4852.7 4860.4 4864.1 4898.8 4904.4 4069.9 4121.5 4121.6 4138.9 4152.1 4658.3 4731.6 4774.8 4796.9 4805.0 5684.4 5699.6 5707.0 5728.3 5753.9 4757.0 4785.7 4795.1 4803.4 4841.0 4958.9 5104.6 5110.2 5116.7 5120.7 5162.5 5185.6 5251.6 5262.5 5266.6 5667.8 5688.2 5689.9 5697.3 5697.6 5244.2 5249.9 5249.9 5257.2 5305.4 5483.9 5527.8 5529.3 5531.9 5532.8 5625.2 5645.2 5687.3 5692.8 5693.3 5375.9 5386.5 5397.5 5435.5 5465.4 5426.0 5474.5 5483.3 5498.5 5509.8 5446.8 5470.9 5472.8 5476.2 5476.8 5397.2 5464.6 5466.1 5537.8 5542.7 5418.8 5432.8 5440.9 5443.6 5488.2 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | [#1] ext.html Cycles:180 Average:30896.61 Median:15668.85 stddev:45741.69 (291.9%) stddev-sans-first:45813.67 09:06:12 INFO - PID 5902 | Values: 662.2 724.7 737.9 1066.8 1068.9 26329.3 27077.2 27079.6 27080.6 27091.6 31769.7 32560.8 32577.3 32583.2 32605.7 7069.0 7205.6 7216.1 7216.1 7220.8 5516.3 5669.4 7094.8 7206.5 7207.2 6802.9 7262.1 7264.3 7271.3 7272.1 7252.6 7289.7 7306.3 7309.4 7323.8 5371.4 5496.3 7134.1 7205.3 7227.6 29541.0 30194.2 30205.8 30277.5 30301.5 2777.6 2816.2 2816.6 2818.7 2819.8 23514.9 23719.6 23726.8 23751.4 23838.3 2710.3 2712.1 2733.8 2734.1 2763.3 137505.0 137619.3 137625.0 137696.0 137716.3 39940.6 39962.2 40048.6 40069.0 40082.2 41818.8 41935.8 41982.8 42000.0 42087.0 12027.7 12076.6 12091.1 12094.6 12105.8 9682.5 9687.1 9691.9 9701.2 9707.6 10357.7 10498.3 10508.1 11154.2 11663.7 4533.5 5186.3 5485.6 5534.3 5571.9 881.9 902.1 904.3 923.8 941.2 20838.3 21648.2 21689.7 21814.6 22188.6 976.2 987.5 992.2 995.0 1010.3 10924.5 10949.4 11180.0 11224.9 11273.5 204165.0 206504.0 206596.0 206777.0 207228.0 39132.8 39345.8 39352.4 39460.0 39517.0 1234.7 1250.6 1265.0 1271.1 1274.0 19025.1 19126.2 19546.9 20594.2 20685.6 28599.0 28688.7 28702.7 28728.6 28730.7 177069.0 178504.1 178624.0 178730.1 179095.0 27753.7 28170.9 28517.9 28634.0 28675.3 26142.9 32749.5 32754.3 34166.8 34209.1 24954.0 26755.2 27122.5 27150.3 27830.3 26258.0 26503.3 26583.9 26767.9 27624.7 29897.3 29923.0 29952.3 29964.3 30272.7 25893.6 26230.9 26363.0 26464.1 26605.3 20556.0 22122.3 22203.9 22360.4 22538.4 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | [#2] jquery.html Cycles:180 Average:29507.19 Median:247729.32 stddev:81188.49 (32.8%) stddev-sans-first:81386.82 09:06:12 INFO - PID 5902 | Values: 395.8 397.9 414.5 420.4 425.7 17170.7 18146.2 18768.9 18936.7 18954.6 18654.5 18754.0 18873.2 19120.5 19265.5 5308.5 5488.0 5529.4 5541.0 5749.2 5490.8 5530.1 5540.9 5541.3 5550.0 5441.2 5485.0 5628.4 5644.2 5659.2 5540.9 5576.1 5614.8 5624.8 5638.1 4849.6 4886.0 4888.1 4892.4 4893.6 22238.0 22785.2 22819.4 22918.5 22981.2 1605.1 1669.5 1680.1 1682.6 1684.7 14843.1 15125.8 15194.3 15234.2 15399.6 2077.1 2080.4 2104.5 2118.9 2123.6 69872.0 88136.6 88581.0 89172.0 89346.0 17829.6 17937.0 18353.8 18395.7 19100.3 33234.0 33412.5 33438.8 33590.0 33965.4 8702.7 8762.3 8853.2 8896.0 9162.5 6969.3 7067.2 7188.6 7274.1 7335.9 9124.2 9459.3 9511.2 9542.5 9685.1 3659.4 3817.6 3836.4 3864.8 3949.8 830.9 840.4 879.5 883.8 888.4 16590.9 16670.7 16711.5 16715.8 17395.3 885.7 888.5 896.8 898.9 905.2 8939.2 8982.8 9334.4 9338.5 9372.3 485326.0 485822.0 490565.0 499413.0 500678.0 90502.0 90596.5 90804.5 91078.0 94149.0 1086.7 1092.2 1114.1 1121.6 1122.0 14149.2 14284.3 14401.1 14441.9 14983.6 39641.8 41162.8 41472.8 41807.4 42598.8 53227.5 53914.5 54333.5 55868.2 55892.7 7157.2 7305.1 7370.6 7376.6 7571.8 10900.6 11293.4 11488.9 11561.2 11917.8 9978.4 10047.9 10151.7 10431.8 10461.6 9786.5 9880.0 9927.7 10020.8 10029.3 9726.0 9784.1 9982.6 10081.6 10480.3 7488.1 7768.7 7769.1 7769.7 7869.2 9294.4 9740.0 9824.9 9837.3 10095.2 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | [#3] mootools.html Cycles:180 Average:6296.25 Median:3457.62 stddev:4102.36 (118.6%) stddev-sans-first:4096.02 09:06:12 INFO - PID 5902 | Values: 1203.8 1341.9 1347.8 1350.1 1364.1 10009.7 10426.3 10449.7 10470.5 10498.9 9981.7 10369.4 10392.8 10409.3 10420.1 2270.7 2310.3 2310.9 2311.3 2312.3 1848.7 2136.5 2203.8 2216.9 2236.5 1918.3 2233.4 2303.7 2312.9 2314.1 2163.1 2163.2 2167.3 2167.4 2167.4 2193.5 2226.7 2232.0 2236.6 2239.0 10067.5 10251.8 10276.6 10279.3 10281.4 5729.1 5896.0 5903.3 5911.0 5928.4 3151.4 3362.2 3366.6 3368.9 3374.9 1000.0 1003.0 1012.9 1043.1 1048.0 14483.9 14525.8 14546.9 14574.6 14605.9 4722.2 4824.1 4980.9 5018.6 5067.0 10926.5 10929.1 10940.1 10940.6 10970.1 5816.5 5822.4 5825.0 5827.2 5831.6 5346.9 5358.1 5447.0 5457.9 5516.9 3834.9 3919.5 3929.8 3966.2 4046.6 1148.6 1151.6 1159.5 1168.6 1176.0 703.3 704.9 718.5 725.2 745.3 5279.7 5324.9 5402.1 5450.0 5626.5 543.9 559.8 565.2 570.4 573.3 3299.2 3451.3 3463.9 3465.9 3503.3 13114.7 13650.2 13878.4 13884.6 13902.2 13365.1 13672.2 13758.2 13758.6 13760.9 9571.9 9624.0 9725.5 9797.3 9799.2 5451.5 5480.3 5501.8 5625.2 5724.1 11947.6 12001.2 12115.6 12163.1 12336.3 12439.0 12466.6 12513.2 12537.9 12588.7 7194.6 7325.7 7326.2 7330.8 7331.0 9182.4 9235.3 9251.8 9292.0 9350.3 7464.3 7668.7 7674.5 7726.8 7871.4 7804.0 7882.8 7927.6 8024.3 8176.8 6649.3 6756.1 6766.2 6767.8 6775.3 4823.8 5012.4 5126.0 5146.5 5206.1 4926.9 4953.2 5032.4 5079.0 5135.1 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | [#4] prototype.html Cycles:180 Average:4609.65 Median:5095.24 stddev:1304.80 (25.6%) stddev-sans-first:1268.45 09:06:12 INFO - PID 5902 | Values: 337.5 361.5 387.4 390.1 393.6 5070.3 5120.2 5160.5 5267.8 5286.4 5147.4 5152.1 5186.8 5214.5 5233.7 4097.0 4110.0 4121.2 4123.3 4126.0 3886.7 4010.6 4017.5 4105.2 4123.0 4077.3 4100.2 4101.4 4104.1 4105.6 4090.6 4092.6 4093.5 4098.6 4100.2 3474.7 3561.8 3641.9 3710.6 3729.5 5019.8 5022.8 5053.1 5054.7 5064.7 4829.7 4854.7 4855.1 4859.4 4862.9 5382.3 5515.8 5561.3 5572.4 5578.4 4176.1 4186.7 4188.5 4197.1 4202.7 5758.6 5793.9 5805.6 5813.5 5825.2 4157.0 4270.8 4312.1 4313.4 4327.4 4057.3 4361.1 4368.5 4370.1 4383.6 4657.1 4657.2 4784.4 4798.5 4801.1 5514.4 5536.8 5539.5 5545.1 5567.9 1486.6 1491.0 1515.5 1518.3 1518.8 1047.1 1067.2 1088.8 1098.4 1099.3 4773.3 4792.8 4795.0 4805.3 4821.7 5707.2 5721.7 5742.3 5745.1 5766.9 4597.8 4784.3 4816.8 4819.9 4822.5 2974.2 3022.6 3029.7 3045.7 3054.4 5230.2 5259.6 5267.8 5310.0 5315.4 5636.3 5880.3 5891.4 5895.6 5911.6 5286.6 5293.8 5297.8 5308.0 5310.7 5749.7 5760.3 5771.2 5776.8 5787.0 5405.8 5584.0 5601.4 5625.2 5627.9 5275.6 5286.5 5289.3 5293.2 5304.5 3883.7 3961.2 3982.3 4000.4 4004.5 5667.9 5676.3 5706.6 5720.4 5731.8 5486.3 5492.5 5497.4 5513.3 5516.1 5363.7 5479.7 5508.5 5510.3 5524.5 5434.1 5436.3 5444.5 5470.5 5473.7 5530.4 5539.5 5563.2 5567.4 5580.2 5246.6 5352.4 5362.8 5409.9 5422.8 09:06:12 INFO - PID 5902 | 09:06:12 INFO - PID 5902 | [#5] yui.html Cycles:180 Average:13767.14 Median:46786.42 stddev:16677.74 (35.6%) stddev-sans-first:16695.55 09:06:12 INFO - PID 5902 | Values: 675.7 677.8 680.8 703.6 741.0 12290.1 12636.5 12660.4 12678.4 12686.3 12825.2 12848.7 12939.4 12954.7 12985.3 899.5 906.1 921.0 921.1 921.2 951.6 961.1 961.8 961.9 962.6 984.9 989.9 990.0 990.7 991.3 979.7 982.5 982.7 983.8 984.0 725.0 726.8 727.6 727.6 727.9 13094.4 13127.4 13143.8 13174.8 13448.4 13320.7 13860.4 13897.5 13931.2 14091.9 10952.0 11216.5 11305.8 11312.5 11426.7 2842.2 2843.7 2898.2 2947.5 2952.2 61919.4 63262.7 63556.0 63657.7 64542.0 10093.3 10268.6 10340.2 10355.4 10836.4 20896.0 20956.6 20961.8 20981.3 20989.8 6274.3 6461.8 6527.5 6564.5 6659.3 3329.5 3377.6 3381.0 3389.4 3470.6 3525.8 3551.9 3608.4 3612.2 3612.4 729.3 733.9 737.1 744.0 747.1 524.2 526.3 532.6 541.9 547.1 7668.4 7734.5 8070.5 8081.8 8277.0 549.9 550.6 551.7 554.3 561.1 3525.1 3573.8 3663.9 3689.5 3694.7 56700.1 58427.1 59550.4 62542.0 62686.4 51312.0 51459.0 51621.2 52179.7 52959.5 46723.5 46849.3 47580.8 47985.5 50037.2 8591.2 8803.4 9056.5 9064.9 9160.9 26191.7 26290.6 26625.9 27073.7 27211.0 32311.2 32362.8 32512.8 33103.0 33207.7 10799.5 10851.2 10909.1 11017.7 11579.1 11354.4 11400.2 11947.2 12111.7 12337.9 10714.8 10821.5 10996.7 11163.1 11208.9 10827.4 10932.0 10949.4 11361.4 11428.4 10892.8 11114.5 11154.6 11188.0 11191.7 7900.4 8110.9 8244.5 8500.7 8546.1 9388.3 9783.2 9791.1 9802.3 9876.4 09:06:12 INFO - PID 5902 | -------- Summary: end -------- 09:06:12 INFO - PID 5902 | 09:06:12 INFO - TEST-INFO | 5902: exit 0 09:06:12 INFO - TEST-OK | dromaeo_css | took 1124101ms 09:06:12 INFO - TEST-START | kraken 09:06:12 INFO - operating with platform_type : linux_ 09:06:12 INFO - Initialising browser for kraken test... 09:06:12 INFO - TEST-INFO | started process 6231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeGMup/profile http://localhost:41040/getInfo.html) 09:06:17 INFO - PID 6231 | __metrics Screen width/height:1600/1200 09:06:17 INFO - PID 6231 | colorDepth:24 09:06:17 INFO - PID 6231 | Browser inner width/height: 1024/697 09:06:17 INFO - PID 6231 | __metrics 09:06:18 INFO - PID 6231 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:06:18 INFO - PID 6231 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:19 INFO - TEST-INFO | 6231: exit 0 09:06:19 INFO - Browser initialized. 09:06:19 INFO - Running cycle 1/1 for kraken test... 09:06:19 INFO - TEST-INFO | started process 6333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeGMup/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:31 INFO - PID 6333 | RSS: Main: 172507136 09:06:31 INFO - PID 6333 | 09:06:34 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41040/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:35 INFO - PID 6333 | RSS: Main: 231350272 09:06:35 INFO - PID 6333 | 09:06:38 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41040/tests/kraken/driver.html?testName=audio-dft) 09:06:38 INFO - PID 6333 | RSS: Main: 211230720 09:06:38 INFO - PID 6333 | 09:06:42 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41040/tests/kraken/driver.html?testName=audio-fft) 09:06:42 INFO - PID 6333 | RSS: Main: 295186432 09:06:42 INFO - PID 6333 | 09:06:44 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41040/tests/kraken/driver.html?testName=audio-oscillator) 09:06:45 INFO - PID 6333 | RSS: Main: 205709312 09:06:45 INFO - PID 6333 | 09:06:47 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41040/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:48 INFO - PID 6333 | RSS: Main: 209645568 09:06:48 INFO - PID 6333 | 09:06:51 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41040/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:52 INFO - PID 6333 | RSS: Main: 248700928 09:06:52 INFO - PID 6333 | 09:06:55 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41040/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:56 INFO - PID 6333 | RSS: Main: 243535872 09:06:56 INFO - PID 6333 | 09:06:59 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41040/tests/kraken/driver.html?testName=json-parse-financial) 09:06:59 INFO - PID 6333 | RSS: Main: 246050816 09:06:59 INFO - PID 6333 | 09:07:01 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41040/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:02 INFO - PID 6333 | RSS: Main: 210784256 09:07:02 INFO - PID 6333 | 09:07:04 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:04 INFO - PID 6333 | RSS: Main: 216887296 09:07:04 INFO - PID 6333 | 09:07:06 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:07 INFO - PID 6333 | RSS: Main: 223612928 09:07:07 INFO - PID 6333 | 09:07:10 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:11 INFO - PID 6333 | RSS: Main: 234774528 09:07:11 INFO - PID 6333 | 09:07:14 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:14 INFO - PID 6333 | RSS: Main: 229609472 09:07:14 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | Cycle 1(1): loaded http://localhost:41040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41040/tests/kraken/driver.html?testName=ai-astar) 09:07:16 INFO - PID 6333 | RSS: Main: 297971712 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | __start_tp_report 09:07:16 INFO - PID 6333 | _x_x_mozilla_page_load 09:07:16 INFO - PID 6333 | _x_x_mozilla_page_load_details 09:07:16 INFO - PID 6333 | |i|pagename|runs| 09:07:16 INFO - PID 6333 | |0;ai-astar;103;111;112;110;112;111;110;111;111;111 09:07:16 INFO - PID 6333 | |1;audio-beat-detection;147;123;123;176;125;124;124;122;152;124 09:07:16 INFO - PID 6333 | |2;audio-dft;167;165;164;164;171;173;175;173;164;163 09:07:16 INFO - PID 6333 | |3;audio-fft;75;76;75;118;78;75;75;74;92;76 09:07:16 INFO - PID 6333 | |4;audio-oscillator;85;84;106;84;84;84;101;85;84;112 09:07:16 INFO - PID 6333 | |5;imaging-gaussian-blur;114;114;114;114;114;113;114;117;115;113 09:07:16 INFO - PID 6333 | |6;imaging-darkroom;152;152;151;152;151;151;151;151;151;151 09:07:16 INFO - PID 6333 | |7;imaging-desaturate;94;94;95;95;96;95;95;94;95;95 09:07:16 INFO - PID 6333 | |8;json-parse-financial;53;54;53;53;54;54;53;53;54;53 09:07:16 INFO - PID 6333 | |9;json-stringify-tinderbox;55;55;57;55;55;55;56;56;56;56 09:07:16 INFO - PID 6333 | |10;stanford-crypto-aes;83;85;83;83;83;83;83;83;83;84 09:07:16 INFO - PID 6333 | |11;stanford-crypto-ccm;134;149;132;133;138;143;131;148;177;132 09:07:16 INFO - PID 6333 | |12;stanford-crypto-pbkdf2;189;195;195;191;194;191;191;192;189;195 09:07:16 INFO - PID 6333 | |13;stanford-crypto-sha256-iterative;78;76;72;71;72;72;70;70;71;71 09:07:16 INFO - PID 6333 | __end_tp_report 09:07:16 INFO - PID 6333 | __start_cc_report 09:07:16 INFO - PID 6333 | _x_x_mozilla_cycle_collect,1978 09:07:16 INFO - PID 6333 | __end_cc_report 09:07:16 INFO - PID 6333 | __startTimestamp1491581236930__endTimestamp 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | ------- Summary: start ------- 09:07:16 INFO - PID 6333 | Number of tests: 14 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.62 (2.4%) stddev-sans-first:0.71 09:07:16 INFO - PID 6333 | Values: 103.0 111.0 112.0 110.0 112.0 111.0 110.0 111.0 111.0 111.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:124.50 stddev:18.33 (14.7%) stddev-sans-first:18.83 09:07:16 INFO - PID 6333 | Values: 147.0 123.0 123.0 176.0 125.0 124.0 124.0 122.0 152.0 124.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#2] audio-dft Cycles:10 Average:167.90 Median:169.00 stddev:4.61 (2.7%) stddev-sans-first:4.87 09:07:16 INFO - PID 6333 | Values: 167.0 165.0 164.0 164.0 171.0 173.0 175.0 173.0 164.0 163.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:13.91 (18.4%) stddev-sans-first:14.56 09:07:16 INFO - PID 6333 | Values: 75.0 76.0 75.0 118.0 78.0 75.0 75.0 74.0 92.0 76.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:10.97 (13.1%) stddev-sans-first:11.42 09:07:16 INFO - PID 6333 | Values: 85.0 84.0 106.0 84.0 84.0 84.0 101.0 85.0 84.0 112.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 09:07:16 INFO - PID 6333 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 114.0 117.0 115.0 113.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 09:07:16 INFO - PID 6333 | Values: 152.0 152.0 151.0 152.0 151.0 151.0 151.0 151.0 151.0 151.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 09:07:16 INFO - PID 6333 | Values: 94.0 94.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 09:07:16 INFO - PID 6333 | Values: 53.0 54.0 53.0 53.0 54.0 54.0 53.0 53.0 54.0 53.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 09:07:16 INFO - PID 6333 | Values: 55.0 55.0 57.0 55.0 55.0 55.0 56.0 56.0 56.0 56.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 09:07:16 INFO - PID 6333 | Values: 83.0 85.0 83.0 83.0 83.0 83.0 83.0 83.0 83.0 84.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:140.50 stddev:14.11 (10.0%) stddev-sans-first:14.69 09:07:16 INFO - PID 6333 | Values: 134.0 149.0 132.0 133.0 138.0 143.0 131.0 148.0 177.0 132.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.20 Median:193.00 stddev:2.39 (1.2%) stddev-sans-first:2.24 09:07:16 INFO - PID 6333 | Values: 189.0 195.0 195.0 191.0 194.0 191.0 191.0 192.0 189.0 195.0 09:07:16 INFO - PID 6333 | 09:07:16 INFO - PID 6333 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:2.63 (3.6%) stddev-sans-first:1.80 09:07:16 INFO - PID 6333 | Values: 78.0 76.0 72.0 71.0 72.0 72.0 70.0 70.0 71.0 71.0 09:07:16 INFO - PID 6333 | -------- Summary: end -------- 09:07:16 INFO - PID 6333 | 09:07:18 INFO - TEST-INFO | 6333: exit 0 09:07:18 INFO - TEST-OK | kraken | took 65337ms 09:07:18 INFO - SUITE-END | took 1189s 09:07:18 INFO - Completed test suite (00:19:49) 09:07:18 INFO - javascript benchmark 09:07:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6625.506665488847, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.662792150981, 2744.9039283625075, 2770.2658795419215, 2778.485980093683, 2800.719928007199, 5107.540321371076, 5228.764705588248, 5234.973825130874, 5260.184671375933, 5330.706811125387, 5204.271402003723, 5225.817096401626, 5237.292965449673, 5245.396779370373, 5281.70950597717, 4382.276924307485, 4636.744979026161, 4738.928916066262, 4777.952220477803, 4785.688930219525, 4687.90624187516, 4707.388039554853, 4735.171345014626, 4742.786574604133, 4787.329773831666, 4572.428446444194, 4589.908201835945, 4620.2607582786595, 4629.027904140101, 4669.042846216517, 4639.837605683785, 4656.278276867091, 4659.930101048487, 4713.175194341011, 4733.763311834429, 4587.931181032287, 4609.262517997105, 4630.907381852344, 4646.605038571725, 4657.2315567931255, 5001.949980500185, 5054.469280725544, 5168.405633352138, 5171.0692075426405, 5195.558377537914, 5583.5254003409755, 5663.830085097454, 5686.232358631614, 5704.315482142128, 5704.71476426177, 5756.280464941882, 5760.452756988079, 5768.596198266123, 5770.913436298459, 5776.364599894008, 5281.630285880028, 5292.497212764782, 5293.920591191135, 5299.099153143975, 5299.788008479656, 5693.060644993612, 5721.828345149652, 5821.068629019336, 5834.358220595731, 5844.327902291206, 5535.197396377584, 5548.056830338852, 5555.111182210827, 5605.355384130796, 5620.3255609326325, 5702.572307076985, 5705.7147142643535, 5707.0, 5707.914381284284, 5735.741891614887, 5597.720113994284, 5618.297712785902, 5642.238297829823, 5657.405972372924, 5673.943260567342, 5511.200875872976, 5524.972375138099, 5584.301962254718, 5586.944130558642, 5626.043572592587, 4852.660313778002, 4860.441049279308, 4864.1001414737675, 4898.755062246873, 4904.43598986114, 4069.9214708102377, 4121.4848143982, 4121.567235440296, 4138.896527586834, 4152.065785198306, 4658.301254811738, 4731.550502702238, 4774.832880849223, 4796.880077998078, 4804.95195048052, 5684.403137670568, 5699.629524081004, 5707.0, 5728.341240757283, 5753.8561535961935, 4756.9762151189025, 4785.736784476818, 4795.136875362398, 4803.375561177025, 4841.007593443335, 4958.8760280993265, 5104.617153713486, 5110.156824124052, 5116.718580478109, 5120.692758434506, 5162.5095615916425, 5185.611079169002, 5251.553617942518, 5262.500062494057, 5266.605004624592, 5667.773289068391, 5688.232088667977, 5689.943100568941, 5697.287839020122, 5697.601167918372, 5244.187150991603, 5249.921251181312, 5249.947500525099, 5257.185136303879, 5305.389880163831, 5483.862903427446, 5527.806526771544, 5529.281193444826, 5531.861703457445, 5532.778688852401, 5625.212470254086, 5645.237892884408, 5687.289088863892, 5692.800751973661, 5693.345265294544, 5375.892482150413, 5386.48828361305, 5397.541208997279, 5435.510804027656, 5465.426130256265, 5426.0, 5474.507294343528, 5483.259759932358, 5498.532624726943, 5509.834704958857, 5446.782128714807, 5470.8905821882545, 5472.808451704172, 5476.205950137128, 5476.753546090516, 5397.244385785914, 5464.562834973272, 5466.125419932791, 5537.778488860562, 5542.722863856871, 5418.756155973069, 5432.837014889559, 5440.918386224131, 5443.564514838724, 5488.17677348401], "value": 5128.54322977696, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.1987395251745, 724.7246046502328, 737.9483436159468, 1066.8026415113209, 1068.9305195162315, 26329.341766455826, 27077.18768436945, 27079.593806092926, 27080.59379109315, 27091.593626095626, 31769.68230317696, 32560.837195813987, 32577.348453030925, 32583.185420364443, 32605.67394326056, 7068.964655176717, 7205.639718014078, 7216.061911951439, 7216.097987751531, 7220.783376498687, 5516.310461192351, 5669.376368599451, 7094.751683691072, 7206.531575447605, 7207.20720720723, 6802.931970680279, 7262.128544574632, 7264.346208841203, 7271.309225623558, 7272.090988626422, 7252.564846109224, 7289.708411663527, 7306.342429181346, 7309.415246780245, 7323.780286591411, 5371.355437347504, 5496.340439147288, 7134.143902731706, 7205.315495027964, 7227.566346019255, 29541.0, 30194.245143871358, 30205.848970755007, 30277.545836812245, 30301.545476817864, 2777.5555911054335, 2816.1973837456226, 2816.605675205473, 2818.7040360762235, 2819.84490853003, 23514.882425587763, 23719.644205336936, 23726.762732372626, 23751.406214844596, 23838.284851454486, 2710.254679963026, 2712.0914493644655, 2733.7676297514736, 2734.1387462949106, 2763.322985868455, 137505.0, 137619.31190344083, 137625.0, 137696.0, 137716.31141844226, 39940.60059399427, 39962.20075598472, 40048.59951400448, 40069.0, 40082.19835603271, 41818.79090604527, 41935.790321048196, 41982.79008604999, 42000.0, 42087.0, 12027.699307517381, 12076.577319793765, 12091.093168012434, 12094.637160885011, 12105.818412723816, 9682.515874206403, 9687.079727425884, 9691.9030809691, 9701.175400091071, 9707.6116955321, 10357.689269321781, 10498.317609355367, 10508.106810921005, 11154.163437742201, 11663.650090497298, 4533.478649955231, 5186.299849520266, 5485.561155107582, 5534.335879694382, 5571.860703482445, 881.8809460722848, 902.0663613160348, 904.263025634106, 923.8013827027087, 941.1670671455811, 20838.27066052681, 21648.24231151902, 21689.67465488019, 21814.56370872574, 22188.556228875656, 976.1507488485064, 987.4717026390847, 992.2359782967219, 995.0397866059143, 1010.282699283517, 10924.50839712199, 10949.397783121845, 11180.0, 11224.887751122547, 11273.492692828842, 204165.0, 206504.0, 206596.0, 206777.0, 207228.0, 39132.804335978704, 39345.80327098403, 39352.409713854315, 39460.0, 39517.0, 1234.734532075608, 1250.581055346451, 1265.025930033887, 1271.053065466215, 1273.9808902866464, 19025.107836537485, 19126.23495060238, 19546.90226548858, 20594.176232950515, 20685.586288273847, 28599.0, 28688.713112868605, 28702.712972870006, 28728.569071464364, 28730.71269287364, 177069.0, 178504.10747946176, 178624.0, 178730.10634947263, 179095.0, 27753.72246277592, 28170.85914570414, 28517.857410712815, 28634.0, 28675.28311792222, 26142.86928565345, 32749.508757369134, 32754.34491310113, 34166.82916585401, 34209.14477137992, 24954.0, 26755.19734407971, 27122.457550848478, 27150.321241969108, 27830.304242393293, 26258.0, 26503.33741656474, 26583.867080664473, 26767.866160669073, 27624.72375276302, 29897.252568685955, 29923.0, 29952.25119372033, 29964.25089372696, 30272.69727302787, 25893.6115958257, 26230.86884565565, 26363.0, 26464.0737574184, 26605.334866628487, 20556.0, 22122.33632991013, 22203.888980554995, 22360.440988975406, 22538.436539085997], "value": 14131.519823725293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.7526545908807, 397.9104701442176, 414.5253684531211, 420.3526569083611, 425.67861264745113, 17170.742438863428, 18146.18342174602, 18768.906155469205, 18936.71594926077, 18954.62090758186, 18654.53363665909, 18754.0, 18873.24507019721, 19120.521986950334, 19265.518362040955, 5308.469153084699, 5487.972560137214, 5529.419410961851, 5541.0, 5749.166370876221, 5490.780368785264, 5530.115181570949, 5540.9168862467095, 5541.307336582927, 5550.028744969634, 5441.183822426648, 5485.0, 5628.352739434956, 5644.209810626516, 5659.179418984245, 5540.944590554083, 5576.107822748361, 5614.831555053355, 5624.775008999635, 5638.126090455966, 4849.5635392814465, 4886.047220791947, 4888.120138375091, 4892.3884514435695, 4893.6329775266995, 22238.0, 22785.20251791179, 22819.42951426211, 22918.54162916749, 22981.19565815205, 1605.1252067623057, 1669.4741156535651, 1680.1095419427722, 1682.5793551612096, 1684.6630673865277, 14843.109413435228, 15125.773113403307, 15194.316255768517, 15234.162121083336, 15399.613059975722, 2077.0860821238757, 2080.3966849613594, 2104.5264815416563, 2118.8622739522034, 2123.6283650361124, 69872.0, 88136.55931720365, 88581.0, 89172.0, 89346.0, 17829.554261143316, 17937.0, 18353.81646183548, 18395.72406413905, 19100.33148839784, 33234.0, 33412.498812517835, 33438.832805836304, 33590.0, 33965.41466901986, 8702.738917832476, 8762.299016078698, 8853.247473964657, 8895.955520222487, 9162.450252984841, 6969.337912898267, 7067.176298174109, 7188.640567971581, 7274.0543729315905, 7335.853282934311, 9124.167849503092, 9459.337846350689, 9511.239100871913, 9542.475163866055, 9685.111403276434, 3659.432787917877, 3817.5790377663784, 3836.366999445116, 3864.787436691009, 3949.7827619481204, 830.8712149616819, 840.4201101240125, 879.5382424227204, 883.823235352932, 888.4180861535575, 16590.917045414695, 16670.749203905365, 16711.498655040366, 16715.832841671672, 17395.304187832597, 885.6545947080643, 888.546841111038, 896.8296023755465, 898.8651702244584, 905.248643625789, 8939.155618805109, 8982.775430614287, 9334.439933604006, 9338.48638324885, 9372.34393592442, 485326.0, 485822.0, 490565.0, 499413.0, 500678.0, 90502.0, 90596.54701726449, 90804.54597727102, 91078.0, 94149.0, 1086.6739978006724, 1092.2408925796494, 1114.0641860836936, 1121.6466812953893, 1121.9831702524468, 14149.151050936976, 14284.285785710881, 14401.135931844123, 14441.927790360982, 14983.550493485212, 39641.79939367527, 41162.79418602888, 41472.792636036625, 41807.37288940608, 42598.78700606477, 53227.467725322254, 53914.46085539251, 54333.45666543284, 55868.16197757118, 55892.72053639706, 7157.212706602374, 7305.1233851938105, 7370.6314684266645, 7376.594287314035, 7571.842025022842, 10900.563977440814, 11293.37886416255, 11488.885111148782, 11561.248518846249, 11917.821232681343, 9978.351407158512, 10047.899521004696, 10151.7462063449, 10431.791364172826, 10461.581536738446, 9786.46174460383, 9880.0, 9927.702168934944, 10020.849687254842, 10029.348092373972, 9726.0, 9784.119429251117, 9982.550785214828, 10081.647142349982, 10480.266381353233, 7488.138864030706, 7768.650410731418, 7769.145394006542, 7769.689212431439, 7869.213078692314, 9294.395864268801, 9740.0, 9824.852627210455, 9837.311388202757, 10095.192384609361], "value": 9432.017231894768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1203.7833190025794, 1341.926194059327, 1347.8449978252497, 1350.1426594112738, 1364.0519838712098, 10009.699709008732, 10426.322289051226, 10449.738756531091, 10470.52882620282, 10498.895011049897, 9981.700548983525, 10369.429681367521, 10392.844107338376, 10409.271351005433, 10420.114290285335, 2270.693456383388, 2310.260716570698, 2310.89600967956, 2311.2835021143414, 2312.3294244669028, 1848.7319338695881, 2136.4979229880964, 2203.8126759225406, 2216.8669879807185, 2236.5303286309895, 1918.2806447582157, 2233.3858188997992, 2303.6544518322303, 2312.8843557822124, 2314.1206341590173, 2163.0915015693445, 2163.242864997246, 2167.2847960173103, 2167.3606286145546, 2167.3822960456196, 2193.5393567350716, 2226.7327920649464, 2232.0402227042364, 2236.5974124657555, 2239.0372139979804, 10067.496625168713, 10251.84622230667, 10276.640317588848, 10279.331843430227, 10281.383117013003, 5729.054705973509, 5896.027155519334, 5903.26209223847, 5911.024680927685, 5928.40715928408, 3151.401233765577, 3362.2098806780386, 3366.646502117291, 3368.9326213475592, 3374.9156271093175, 1000.0399616368295, 1003.0, 1012.8885822559513, 1043.0925095167177, 1048.0096308988009, 14483.927580362137, 14525.78211326831, 14546.854531454655, 14574.562763117123, 14605.92697036508, 4722.197226471508, 4824.107540105092, 4980.90038199234, 5018.573421259161, 5066.9746651266505, 10926.453677316262, 10929.125669946385, 10940.070094041936, 10940.56237750481, 10970.122390208764, 5816.47651711348, 5822.446867547576, 5825.0, 5827.24245848037, 5831.562632802556, 5346.946530534645, 5358.062339090644, 5447.0, 5457.918131228034, 5516.862078448071, 3834.884953451345, 3919.5492518360184, 3929.8428062877165, 3966.2464131814863, 4046.59534046593, 1148.62095508482, 1151.631477927072, 1159.4608507044265, 1168.5559487394735, 1175.9764804703857, 703.3283214530112, 704.9224585295614, 718.4862823081522, 725.1551941987631, 745.3217572009445, 5279.736013199325, 5324.946750532445, 5402.108652072364, 5450.0, 5626.521745651584, 543.8993786149575, 559.8040685759952, 565.2171742137169, 570.3925319534683, 573.2519062623317, 3299.1752061984503, 3451.3442445935193, 3463.8960831175104, 3465.9306813864087, 3503.2993401319836, 13114.672133196746, 13650.180989140683, 13878.4448622056, 13884.58346249614, 13902.16587004783, 13365.131266467648, 13672.179669219879, 13758.243296618582, 13758.587242382744, 13760.862391376158, 9571.899231588317, 9623.951880240695, 9725.465099419458, 9797.31418800677, 9799.167070799062, 5451.536619387396, 5480.287562616834, 5501.779928802963, 5625.240592519957, 5724.055530837365, 11947.641570752892, 12001.1599188056, 12115.575954841539, 12163.087768417581, 12336.321502317458, 12439.0, 12466.563670271496, 12513.249205047363, 12537.93731031339, 12588.685282868002, 7194.640267986684, 7325.706971721072, 7326.230745771617, 7330.816729581803, 7331.010313607595, 9182.449053056838, 9235.307351948497, 9251.76870578241, 9292.0, 9350.25197984146, 7464.328210461084, 7668.661058377248, 7674.53952762836, 7726.806829829075, 7871.370290376871, 7803.985481887318, 7882.842343153219, 7927.60361981887, 8024.277814996678, 8176.754697359089, 6649.335066493505, 6756.087928129639, 6766.18805743314, 6767.763128290486, 6775.254721980479, 4823.807047718052, 5012.373453318335, 5126.0, 5146.511081447256, 5206.062908676475, 4926.901461970812, 4953.18272485036, 5032.370953630796, 5079.034983353151, 5135.075686376339], "value": 4685.468574915219, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.50218427818953, 361.47405524961187, 387.40339876590053, 390.0521732190777, 393.59459756450866, 5070.315507406499, 5120.1551743962245, 5160.542436567499, 5267.762950667219, 5286.392064912527, 5147.408048074472, 5152.149895267276, 5186.766595503202, 5214.504622060907, 5233.73831308434, 4096.97951510242, 4109.979450102745, 4121.196366708486, 4123.278426275405, 4126.0, 3886.727929044968, 4010.6390424861756, 4017.493439960015, 4105.2405305018665, 4122.97938510307, 4077.3068578341754, 4100.2414553307735, 4101.384792281152, 4104.076582768883, 4105.568915263899, 4090.6318431341174, 4092.611201935826, 4093.5292441369324, 4098.631123198927, 4100.220958017967, 3474.6872781449792, 3561.821908904544, 3641.8543258269638, 3710.5732840723394, 3729.515163028816, 5019.774110165052, 5022.824201152978, 5053.115704751691, 5054.721990290533, 5064.733247055628, 4829.705889702398, 4854.732989685566, 4855.101806165871, 4859.3682821233015, 4862.854114376574, 5382.327209098863, 5515.834524964257, 5561.304836895388, 5572.442755724435, 5578.442155784389, 4176.14389050244, 4186.6859985501205, 4188.497380314351, 4197.097624010852, 4202.663786897041, 5758.596898217126, 5793.8551536211935, 5805.564582656276, 5813.476787089097, 5825.15535247391, 4157.0, 4270.765107919095, 4312.116016216668, 4313.374560688682, 4327.37253098299, 4057.2899742544937, 4361.127774445124, 4368.5194628590825, 4370.125974805052, 4383.561643835655, 4657.115148121846, 4657.184992626277, 4784.378030856036, 4798.49615790344, 4801.087793319258, 5514.36584792754, 5536.833894983157, 5539.5014448699, 5545.112781954868, 5567.860803479864, 1486.5837565481681, 1490.9776353354707, 1515.4695856450376, 1518.3319339490588, 1518.8481151884944, 1047.1413440978324, 1067.2209287220373, 1088.804015277242, 1098.3629494892944, 1099.2854644481151, 4773.260144677581, 4792.808287668524, 4794.95205047952, 4805.27920811881, 4821.734804585782, 5707.230758464889, 5721.713914304268, 5742.28221472316, 5745.13822926556, 5766.942330576724, 4597.770111494412, 4784.30627559002, 4816.783244753994, 4819.903601927942, 4822.541858523435, 2974.2267010577407, 3022.5617285493922, 3029.6515900671266, 3045.695430456981, 3054.4349295380425, 5230.215467679878, 5259.579233661298, 5267.789288428497, 5310.017646735367, 5315.388730296066, 5636.323641163087, 5880.2943646761805, 5891.440313170242, 5895.55783316253, 5911.586188966817, 5286.577073834084, 5293.841184764463, 5297.841064768063, 5308.0, 5310.654807437581, 5749.683767392667, 5760.337561180518, 5771.192033115283, 5776.797812076557, 5787.045137552257, 5405.8107966221, 5584.0, 5601.383847776659, 5625.156226566048, 5627.8593035174445, 5275.577953763766, 5286.524212820711, 5289.285946397187, 5293.179557168645, 5304.549113325256, 3883.650471457582, 3961.207758448264, 3982.287616325008, 4000.3799411091327, 4004.4794176756836, 5667.894760521659, 5676.34722006958, 5706.572007099401, 5720.427957204412, 5731.828045158652, 5486.31421072366, 5492.505674489315, 5497.422770609189, 5513.3108361454815, 5516.089845175501, 5363.678179309254, 5479.726013699219, 5508.531774799187, 5510.283663123768, 5524.502794748492, 5434.10337294342, 5436.320459942507, 5444.50999410055, 5470.452954704498, 5473.726313684379, 5530.391656917655, 5539.501444869981, 5563.193336966198, 5567.387587365306, 5580.190872323409, 5246.580273578181, 5352.384475785335, 5362.7586758596735, 5409.864753381197, 5422.810201642924], "value": 4218.38604099013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.7297081167533, 677.8169894128586, 680.7549282258386, 703.581369085394, 740.9518381305218, 12290.078244131691, 12636.49454021838, 12660.366981650915, 12678.429470673831, 12686.302253376061, 12825.230486170836, 12848.67878303043, 12939.41772620232, 12954.676133096676, 12985.285809280485, 899.4513346858428, 906.1074841281333, 920.9585568649427, 921.1203300847675, 921.1709461484684, 951.6241084771511, 961.1109723505764, 961.7691753979065, 961.8653388525577, 962.5572236771094, 984.9261305402088, 989.8812142542905, 990.044606954289, 990.6582229130938, 991.33085167512, 979.6962941488126, 982.5332966840693, 982.7248370456248, 983.788485475619, 984.0208992052917, 725.0031207090251, 726.8473620539693, 727.6252729844134, 727.6434547071949, 727.9162896266891, 13094.410751516205, 13127.40926658293, 13143.802842957364, 13174.802377964243, 13448.394822233024, 13320.733585328238, 13860.356389353887, 13897.513587024405, 13931.233782141979, 14091.929540352336, 10952.0, 11216.49525771334, 11305.830412543819, 11312.547498100066, 11426.657200284004, 2842.1757690269797, 2843.701411351799, 2898.2029941765973, 2947.513660246057, 2952.1733914503975, 61919.38080619181, 63262.68368658173, 63556.0, 63657.681711591606, 64542.03186952246, 10093.293469457214, 10268.64059757905, 10340.172786177087, 10355.430451325099, 10836.40399778004, 20896.0, 20956.580868382545, 20961.79038209629, 20981.265655702282, 20989.79010209909, 6274.341194174637, 6461.806145815539, 6527.5430719849155, 6564.4748420127235, 6659.334066593399, 3329.4672852343992, 3377.628460869302, 3380.983095084558, 3389.4237979543536, 3470.6008808986785, 3525.7884526928465, 3551.8756843510355, 3608.386574282378, 3612.1872578670113, 3612.440071788877, 729.2561587181045, 733.8935854301203, 737.0712901743841, 743.9888401673979, 747.1184002876549, 524.2267655208537, 526.2921370756327, 532.5579768791894, 541.9241306217133, 547.075442502178, 7668.424868134912, 7734.4585878989055, 8070.47541909774, 8081.797955051171, 8277.0, 549.851540084175, 550.5980634137102, 551.743439300719, 554.2794367322465, 561.0630247486707, 3525.0834782956617, 3573.8213089345427, 3663.8785380163026, 3689.5019172411917, 3694.7413681042067, 56700.149497757564, 58427.123593146134, 59550.404495954484, 62542.0, 62686.373136268965, 51312.0, 51459.0, 51621.22568161481, 52179.73910130425, 52959.470405296226, 46723.5327646726, 46849.29726054112, 47580.7620961893, 47985.5201447988, 50037.24944125841, 8591.226789588967, 8803.427777194462, 9056.456612603264, 9064.909350906406, 9160.862587061332, 26191.73808261893, 26290.605640915783, 26625.866870665523, 27073.729262707122, 27211.0, 32311.192220194684, 32362.83818580892, 32512.83743581267, 33103.0, 33207.667923320456, 10799.514021868878, 10851.240413171317, 10909.127269818237, 11017.724556886142, 11579.131565132817, 11354.432278386214, 11400.201985860911, 11947.223430476992, 12111.697207569881, 12337.938310308391, 10714.839277410689, 10821.458927053773, 10996.65271549087, 11163.051140653135, 11208.943955280172, 10827.350358978172, 10932.0, 10949.397783121685, 11361.375124367909, 11428.371439570903, 10892.836607451052, 11114.49984750672, 11154.553817847196, 11188.04901583342, 11191.66425007251, 7900.4074694397, 8110.878336824834, 8244.54654993981, 8500.659973600987, 8546.145385461405, 9388.342816002814, 9783.217342612716, 9791.069848364394, 9802.313838031554, 9876.40741555509], "value": 6260.291721782452, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 110.0, 112.0, 111.0, 110.0, 111.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 123.0, 176.0, 125.0, 124.0, 124.0, 122.0, 152.0, 124.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 164.0, 164.0, 171.0, 173.0, 175.0, 173.0, 164.0, 163.0], "value": 167.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 118.0, 78.0, 75.0, 75.0, 74.0, 92.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 106.0, 84.0, 84.0, 84.0, 101.0, 85.0, 84.0, 112.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 117.0, 115.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 152.0, 151.0, 151.0, 151.0, 151.0, 151.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 149.0, 132.0, 133.0, 138.0, 143.0, 131.0, 148.0, 177.0, 132.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 195.0, 195.0, 191.0, 194.0, 191.0, 191.0, 192.0, 189.0, 195.0], "value": 192.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 72.0, 71.0, 72.0, 72.0, 70.0, 70.0, 71.0, 71.0], "value": 72.3, "unit": "score"}]}]} 09:07:18 INFO - Return code: 0 09:07:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:07:18 ERROR - # TBPL SUCCESS # 09:07:18 INFO - Running post-action listener: _resource_record_post_action 09:07:18 INFO - [mozharness: 2017-04-07 16:07:18.709511Z] Finished run-tests step (success) 09:07:18 INFO - Running post-run listener: _resource_record_post_run 09:07:18 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 362463232; Read time: 32; Write time: 197476 09:07:18 INFO - TinderboxPrint: CPU usage
13.0% 09:07:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 32 09:07:18 INFO - TinderboxPrint: I/O write bytes / time
362,463,232 / 197,476 09:07:18 INFO - TinderboxPrint: CPU idle
8,367.6 (87.0%) 09:07:18 INFO - TinderboxPrint: CPU user
1,203.2 (12.5%) 09:07:18 INFO - TinderboxPrint: Swap in / out
0 / 0 09:07:18 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 103211008; Read time: 0; Write time: 87404 09:07:18 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259252224; Read time: 16; Write time: 110072 09:07:19 INFO - Running post-run listener: _upload_blobber_files 09:07:19 INFO - Blob upload gear active. 09:07:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:19 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:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:29 INFO - (blobuploader) - INFO - Done attempting. 09:07:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:07:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:34 INFO - (blobuploader) - INFO - Done attempting. 09:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:38 INFO - (blobuploader) - INFO - Done attempting. 09:07:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:07:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:42 INFO - (blobuploader) - INFO - Done attempting. 09:07:42 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:42 INFO - Return code: 0 09:07:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f032a785fd93997150d6f36739f29b1cc038a12512ef3617e92a3889ddfc954879fd5b4c53a14df448ad08630891ebe922add65fc2a276764cc3e441102a7c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d95af62ccebdc401edc60dd6f8c293ab536ebdada2cb150be6eaced2af1aa72d2d4944b70d6f7ae4d3e52b2049c789a9ea2bfba9d759bc9c6078de400185d9b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763bef4003c6289dd65511dbfb05a5e4fbfd9f29eb0ad727cc7e335ab2604be744ea16849ace66b3457071e5b0e8b36d74308f1996f7fff7b28ee0621e34fd7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dad37b2e1dbe2f6b2c282c635adb7d90b88a5728f9394435e78f2e5cc31d86c5ccf12a65e5aaf5b055b1d563c8fa95c7d7e6a9fcd92863f7c2fc1da8d708433"} 09:07:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:42 INFO - Contents: 09:07:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f032a785fd93997150d6f36739f29b1cc038a12512ef3617e92a3889ddfc954879fd5b4c53a14df448ad08630891ebe922add65fc2a276764cc3e441102a7c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d95af62ccebdc401edc60dd6f8c293ab536ebdada2cb150be6eaced2af1aa72d2d4944b70d6f7ae4d3e52b2049c789a9ea2bfba9d759bc9c6078de400185d9b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763bef4003c6289dd65511dbfb05a5e4fbfd9f29eb0ad727cc7e335ab2604be744ea16849ace66b3457071e5b0e8b36d74308f1996f7fff7b28ee0621e34fd7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dad37b2e1dbe2f6b2c282c635adb7d90b88a5728f9394435e78f2e5cc31d86c5ccf12a65e5aaf5b055b1d563c8fa95c7d7e6a9fcd92863f7c2fc1da8d708433"} 09:07:42 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:42 INFO - Copying logs to upload dir... 09:07:42 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.240205 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-07 09:07:42.838213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 09:07:42.842313) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f032a785fd93997150d6f36739f29b1cc038a12512ef3617e92a3889ddfc954879fd5b4c53a14df448ad08630891ebe922add65fc2a276764cc3e441102a7c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d95af62ccebdc401edc60dd6f8c293ab536ebdada2cb150be6eaced2af1aa72d2d4944b70d6f7ae4d3e52b2049c789a9ea2bfba9d759bc9c6078de400185d9b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763bef4003c6289dd65511dbfb05a5e4fbfd9f29eb0ad727cc7e335ab2604be744ea16849ace66b3457071e5b0e8b36d74308f1996f7fff7b28ee0621e34fd7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dad37b2e1dbe2f6b2c282c635adb7d90b88a5728f9394435e78f2e5cc31d86c5ccf12a65e5aaf5b055b1d563c8fa95c7d7e6a9fcd92863f7c2fc1da8d708433"} build_url:https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/OaV4HxZ1TIiM2X3eVMi6rQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f032a785fd93997150d6f36739f29b1cc038a12512ef3617e92a3889ddfc954879fd5b4c53a14df448ad08630891ebe922add65fc2a276764cc3e441102a7c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d95af62ccebdc401edc60dd6f8c293ab536ebdada2cb150be6eaced2af1aa72d2d4944b70d6f7ae4d3e52b2049c789a9ea2bfba9d759bc9c6078de400185d9b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763bef4003c6289dd65511dbfb05a5e4fbfd9f29eb0ad727cc7e335ab2604be744ea16849ace66b3457071e5b0e8b36d74308f1996f7fff7b28ee0621e34fd7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dad37b2e1dbe2f6b2c282c635adb7d90b88a5728f9394435e78f2e5cc31d86c5ccf12a65e5aaf5b055b1d563c8fa95c7d7e6a9fcd92863f7c2fc1da8d708433"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 09:07:42.867960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:07:42.868283) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1491579980.431954-1219405750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:07:42.951858) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 09:07:42.952167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 09:07:42.952466) ========= ========= Total master_lag: 0.17 =========