builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1484042076.38 results: success (0) revision: a61edc75cfb522ad1a87bb2be1e1419049361ac4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.378478) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.378967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.379263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.434636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.434896) ========= 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=eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 01:54:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.3M=0s 2017-01-10 01:54:37 (45.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087281 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.536544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.536877) ========= 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=eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.587876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 01:54:36.588262) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev a61edc75cfb522ad1a87bb2be1e1419049361ac4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev a61edc75cfb522ad1a87bb2be1e1419049361ac4 --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=eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 01:54:37,213 truncating revision to first 12 chars 2017-01-10 01:54:37,213 Setting DEBUG logging. 2017-01-10 01:54:37,213 attempt 1/10 2017-01-10 01:54:37,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/a61edc75cfb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 01:54:38,584 unpacking tar archive at: graphics-a61edc75cfb5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.676869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 01:54:38.279372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.279695) ========= script_repo_revision: a61edc75cfb522ad1a87bb2be1e1419049361ac4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.280097) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.280383) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.288366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-01-10 01:54:38.288723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:54:39 INFO - MultiFileLogger online at 20170110 01:54:39 in /builds/slave/test 01:54:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 01:54:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:54:39 INFO - {'append_to_log': False, 01:54:39 INFO - 'base_work_dir': '/builds/slave/test', 01:54:39 INFO - 'blob_upload_branch': 'Graphics', 01:54:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:54:39 INFO - 'branch': 'Graphics', 01:54:39 INFO - 'buildbot_json_path': 'buildprops.json', 01:54:39 INFO - 'config_files': ('talos/linux_config.py',), 01:54:39 INFO - 'default_actions': ('clobber', 01:54:39 INFO - 'read-buildbot-config', 01:54:39 INFO - 'download-and-extract', 01:54:39 INFO - 'populate-webroot', 01:54:39 INFO - 'create-virtualenv', 01:54:39 INFO - 'install', 01:54:39 INFO - 'run-tests'), 01:54:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:54:39 INFO - 'download_minidump_stackwalk': True, 01:54:39 INFO - 'download_symbols': 'ondemand', 01:54:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:54:39 INFO - 'tooltool.py': '/tools/tooltool.py', 01:54:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:54:39 INFO - '/tools/misc-python/virtualenv.py')}, 01:54:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:54:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:54:39 INFO - 'installer_path': 'installer.exe', 01:54:39 INFO - 'log_level': 'info', 01:54:39 INFO - 'log_name': 'talos', 01:54:39 INFO - 'log_to_console': True, 01:54:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:54:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:54:39 INFO - 'opt_config_files': (), 01:54:39 INFO - 'pip_index': False, 01:54:39 INFO - 'sps_profile': False, 01:54:39 INFO - 'sps_profile_interval': 0, 01:54:39 INFO - 'suite': 'dromaeojs-e10s', 01:54:39 INFO - 'system_bits': '32', 01:54:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:54:39 INFO - 'title': 'talos-linux64-ix-010', 01:54:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:54:39 INFO - 'use_talos_json': True, 01:54:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:54:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:54:39 INFO - 'work_dir': 'build'} 01:54:39 INFO - [mozharness: 2017-01-10 09:54:39.014496Z] Running clobber step. 01:54:39 INFO - Running pre-action listener: _resource_record_pre_action 01:54:39 INFO - Running main action method: clobber 01:54:39 INFO - rmtree: /builds/slave/test/build 01:54:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:54:40 INFO - Running post-action listener: _resource_record_post_action 01:54:40 INFO - [mozharness: 2017-01-10 09:54:40.008059Z] Finished clobber step (success) 01:54:40 INFO - [mozharness: 2017-01-10 09:54:40.008158Z] Running read-buildbot-config step. 01:54:40 INFO - Running pre-action listener: _resource_record_pre_action 01:54:40 INFO - Running main action method: read_buildbot_config 01:54:40 INFO - Using buildbot properties: 01:54:40 INFO - { 01:54:40 INFO - "project": "", 01:54:40 INFO - "product": "firefox", 01:54:40 INFO - "who": "nsilva@mozilla.com", 01:54:40 INFO - "installer_path": "public/build/target.tar.bz2", 01:54:40 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 01:54:40 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 01:54:40 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 01:54:40 INFO - "stage_platform": "linux64", 01:54:40 INFO - "basedir": "/builds/slave/test", 01:54:40 INFO - "buildnumber": 32, 01:54:40 INFO - "platform": "ubuntu64_hw", 01:54:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:54:40 INFO - "slavebuilddir": "test", 01:54:40 INFO - "taskId": "XSOLIhfwSPO-T9XOXLvw1g", 01:54:40 INFO - "branch": "graphics", 01:54:40 INFO - "script_repo_revision": "default", 01:54:40 INFO - "revision": "a61edc75cfb522ad1a87bb2be1e1419049361ac4", 01:54:40 INFO - "slavename": "talos-linux64-ix-010", 01:54:40 INFO - "repo_path": "projects/graphics" 01:54:40 INFO - } 01:54:40 INFO - Finding installer, test and symbols from parent task. 01:54:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XSOLIhfwSPO-T9XOXLvw1g'}, attempt #1 01:54:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XSOLIhfwSPO-T9XOXLvw1g'}, attempt #1 01:54:40 INFO - Task dependencies: GKsmARG4RIeFwTPkb8pH3g 01:54:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g'}, attempt #1 01:54:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/test_packages.json 01:54:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip 01:54:41 INFO - Running post-action listener: _resource_record_post_action 01:54:41 INFO - [mozharness: 2017-01-10 09:54:41.403190Z] Finished read-buildbot-config step (success) 01:54:41 INFO - [mozharness: 2017-01-10 09:54:41.403408Z] Running download-and-extract step. 01:54:41 INFO - Running pre-action listener: _resource_record_pre_action 01:54:41 INFO - Running main action method: download_and_extract 01:54:41 INFO - mkdir: /builds/slave/test/build/tests 01:54:41 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')]} 01:54:41 INFO - trying https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.test_packages.json 01:54:41 INFO - Downloading https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:54:41 INFO - Downloaded 896 bytes. 01:54:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:54:41 INFO - Using the following test package requirements: 01:54:41 INFO - {u'common': [u'target.common.tests.zip'], 01:54:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:54:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:54:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:54:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:54:41 INFO - u'mozbase': [u'target.common.tests.zip'], 01:54:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:54:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:54:41 INFO - u'web-platform': [u'target.common.tests.zip', 01:54:41 INFO - u'target.web-platform.tests.zip'], 01:54:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:54:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:54:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip 01:54:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:54:41 INFO - Fetch https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip into memory 01:54:42 INFO - Expected file size: 20251352 01:54:42 INFO - Obtained file size: 20251352 01:54:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:54:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip 01:54:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:54:46 INFO - Fetch https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip into memory 01:54:47 INFO - Expected file size: 20251352 01:54:47 INFO - Obtained file size: 20251352 01:54:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.talos.tests.zip 01:54:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:54:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.talos.tests.zip into memory 01:54:52 INFO - Expected file size: 14403537 01:54:52 INFO - Obtained file size: 14403537 01:54: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')]} 01:54:53 INFO - trying https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:54:55 INFO - Downloaded 55923122 bytes. 01:54:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:55 INFO - mkdir: /builds/slave/test/properties 01:54:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:54:55 INFO - Writing to file /builds/slave/test/properties/build_url 01:54:55 INFO - Contents: 01:54:55 INFO - build_url:https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:55 INFO - Running post-action listener: _resource_record_post_action 01:54:55 INFO - Running post-action listener: set_extra_try_arguments 01:54:55 INFO - [mozharness: 2017-01-10 09:54:55.065665Z] Finished download-and-extract step (success) 01:54:55 INFO - [mozharness: 2017-01-10 09:54:55.065762Z] Running populate-webroot step. 01:54:55 INFO - Running pre-action listener: _resource_record_pre_action 01:54:55 INFO - Running main action method: populate_webroot 01:54:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:54:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:54:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:54:55 INFO - '--tppagecycles', 01:54:55 INFO - '7'], 01:54:55 INFO - 'tests': ['tsvgm']}}, 01:54:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:54:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:54:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:54:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:54:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:54:55 INFO - 'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:54:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:54:55 INFO - 'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['damp', 'tps']}, 01:54:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:54:55 INFO - 'tests': ['damp', 'tps']}, 01:54:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['dromaeo_dom']}, 01:54:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:54:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['basic_compositor_video']}, 01:54:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:54:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['a11yr', 01:54:55 INFO - 'ts_paint', 01:54:55 INFO - 'tpaint', 01:54:55 INFO - 'sessionrestore', 01:54:55 INFO - 'sessionrestore_no_auto_restore', 01:54:55 INFO - 'tabpaint']}, 01:54:55 INFO - 'other-e10s': {'tests': ['a11yr', 01:54:55 INFO - 'ts_paint', 01:54:55 INFO - 'tpaint', 01:54:55 INFO - 'sessionrestore', 01:54:55 INFO - 'sessionrestore_no_auto_restore', 01:54:55 INFO - 'tabpaint']}, 01:54:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:54:55 INFO - 'ts_paint', 01:54:55 INFO - 'tpaint', 01:54:55 INFO - 'sessionrestore', 01:54:55 INFO - 'sessionrestore_no_auto_restore', 01:54:55 INFO - 'tabpaint']}, 01:54:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:54:55 INFO - 'ts_paint', 01:54:55 INFO - 'tpaint', 01:54:55 INFO - 'sessionrestore', 01:54:55 INFO - 'sessionrestore_no_auto_restore', 01:54:55 INFO - 'tabpaint']}, 01:54:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['a11yr', 01:54:55 INFO - 'ts_paint', 01:54:55 INFO - 'tpaint', 01:54:55 INFO - 'sessionrestore', 01:54:55 INFO - 'sessionrestore_no_auto_restore', 01:54:55 INFO - 'tabpaint']}, 01:54:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['a11yr', 01:54:55 INFO - 'ts_paint', 01:54:55 INFO - 'tpaint', 01:54:55 INFO - 'sessionrestore', 01:54:55 INFO - 'sessionrestore_no_auto_restore', 01:54:55 INFO - 'tabpaint']}, 01:54:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['tsvgx', 01:54:55 INFO - 'tsvgr_opacity', 01:54:55 INFO - 'tart', 01:54:55 INFO - 'tscrollx', 01:54:55 INFO - 'cart', 01:54:55 INFO - 'tsvg_static']}, 01:54:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:54:55 INFO - 'tsvgr_opacity', 01:54:55 INFO - 'tart', 01:54:55 INFO - 'tscrollx', 01:54:55 INFO - 'cart', 01:54:55 INFO - 'tsvg_static']}, 01:54:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:54:55 INFO - 'talos_options': ['--disable-e10s'], 01:54:55 INFO - 'tests': ['tp5o']}, 01:54:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:54:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:54:55 INFO - 'talos_options': ['--disable-e10s', 01:54:55 INFO - '--xperf_path', 01:54:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:55 INFO - 'tests': ['tp5n']}, 01:54:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:54:55 INFO - 'talos_options': ['--xperf_path', 01:54:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:55 INFO - 'tests': ['tp5n']}}, 01:54:55 INFO - 'talos.zip': {'path': '', 01:54:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:54:55 INFO - Running post-action listener: _resource_record_post_action 01:54:55 INFO - [mozharness: 2017-01-10 09:54:55.079087Z] Finished populate-webroot step (success) 01:54:55 INFO - [mozharness: 2017-01-10 09:54:55.079180Z] Running create-virtualenv step. 01:54:55 INFO - Running pre-action listener: _resource_record_pre_action 01:54:55 INFO - Running main action method: create_virtualenv 01:54:55 INFO - Creating virtualenv /builds/slave/test/build/venv 01:54:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:54:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:54:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:54:55 INFO - Using real prefix '/usr' 01:54:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:54:57 INFO - Installing pip.................done. 01:54:57 INFO - Return code: 0 01:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:54:57 INFO - Reading from file tmpfile_stdout 01:54:57 INFO - Output received: 01:54:57 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) 01:54:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:54:57 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')]} 01:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 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')]} 01:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 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 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:54:57 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 01:54:57 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 01:54:57 INFO - Using env: {'DISPLAY': ':0', 01:54:57 INFO - 'HOME': '/home/cltbld', 01:54:57 INFO - 'LANG': 'en_US.UTF-8', 01:54:57 INFO - 'LANGUAGE': 'en_US:en', 01:54:57 INFO - 'LOGNAME': 'cltbld', 01:54:57 INFO - 'MAIL': '/var/mail/cltbld', 01:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:57 INFO - 'MOZ_NO_REMOTE': '1', 01:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:57 INFO - 'NO_EM_RESTART': '1', 01:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:57 INFO - 'PWD': '/builds/slave/test', 01:54:57 INFO - 'SHELL': '/bin/bash', 01:54:57 INFO - 'SHLVL': '1', 01:54:57 INFO - 'TERM': 'linux', 01:54:57 INFO - 'TMOUT': '86400', 01:54:57 INFO - 'USER': 'cltbld', 01:54:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:57 INFO - '_': '/tools/buildbot/bin/python'} 01:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:54:58 INFO - Cleaning up... 01:54:58 INFO - Return code: 0 01:54:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:54:58 INFO - Using env: {'DISPLAY': ':0', 01:54:58 INFO - 'HOME': '/home/cltbld', 01:54:58 INFO - 'LANG': 'en_US.UTF-8', 01:54:58 INFO - 'LANGUAGE': 'en_US:en', 01:54:58 INFO - 'LOGNAME': 'cltbld', 01:54:58 INFO - 'MAIL': '/var/mail/cltbld', 01:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:58 INFO - 'MOZ_NO_REMOTE': '1', 01:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:58 INFO - 'NO_EM_RESTART': '1', 01:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:58 INFO - 'PWD': '/builds/slave/test', 01:54:58 INFO - 'SHELL': '/bin/bash', 01:54:58 INFO - 'SHLVL': '1', 01:54:58 INFO - 'TERM': 'linux', 01:54:58 INFO - 'TMOUT': '86400', 01:54:58 INFO - 'USER': 'cltbld', 01:54:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:58 INFO - '_': '/tools/buildbot/bin/python'} 01:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:58 INFO - Downloading/unpacking psutil>=3.1.1 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:55:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:00 INFO - Installing collected packages: psutil 01:55:00 INFO - Running setup.py install for psutil 01:55:00 INFO - building 'psutil._psutil_linux' extension 01:55:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:55:00 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 01:55:00 INFO - building 'psutil._psutil_posix' extension 01:55:00 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 01:55:00 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 01:55:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:00 INFO - Successfully installed psutil 01:55:00 INFO - Cleaning up... 01:55:00 INFO - Return code: 0 01:55:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:55:00 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')]} 01:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:00 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')]} 01:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:00 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 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:00 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 01:55:00 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 01:55:00 INFO - Using env: {'DISPLAY': ':0', 01:55:00 INFO - 'HOME': '/home/cltbld', 01:55:00 INFO - 'LANG': 'en_US.UTF-8', 01:55:00 INFO - 'LANGUAGE': 'en_US:en', 01:55:00 INFO - 'LOGNAME': 'cltbld', 01:55:00 INFO - 'MAIL': '/var/mail/cltbld', 01:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:00 INFO - 'MOZ_NO_REMOTE': '1', 01:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:00 INFO - 'NO_EM_RESTART': '1', 01:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:00 INFO - 'PWD': '/builds/slave/test', 01:55:00 INFO - 'SHELL': '/bin/bash', 01:55:00 INFO - 'SHLVL': '1', 01:55:00 INFO - 'TERM': 'linux', 01:55:00 INFO - 'TMOUT': '86400', 01:55:00 INFO - 'USER': 'cltbld', 01:55:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:00 INFO - '_': '/tools/buildbot/bin/python'} 01:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:55:03 INFO - Installing collected packages: mozsystemmonitor 01:55:03 INFO - Running setup.py install for mozsystemmonitor 01:55:03 INFO - Successfully installed mozsystemmonitor 01:55:03 INFO - Cleaning up... 01:55:03 INFO - Return code: 0 01:55:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:55:03 INFO - Using env: {'DISPLAY': ':0', 01:55:03 INFO - 'HOME': '/home/cltbld', 01:55:03 INFO - 'LANG': 'en_US.UTF-8', 01:55:03 INFO - 'LANGUAGE': 'en_US:en', 01:55:03 INFO - 'LOGNAME': 'cltbld', 01:55:03 INFO - 'MAIL': '/var/mail/cltbld', 01:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:03 INFO - 'MOZ_NO_REMOTE': '1', 01:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:03 INFO - 'NO_EM_RESTART': '1', 01:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:03 INFO - 'PWD': '/builds/slave/test', 01:55:03 INFO - 'SHELL': '/bin/bash', 01:55:03 INFO - 'SHLVL': '1', 01:55:03 INFO - 'TERM': 'linux', 01:55:03 INFO - 'TMOUT': '86400', 01:55:03 INFO - 'USER': 'cltbld', 01:55:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:03 INFO - '_': '/tools/buildbot/bin/python'} 01:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:03 INFO - Downloading/unpacking jsonschema==2.5.1 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:55:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:05 INFO - Downloading functools32-3.2.3-2.tar.gz 01:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:55:05 INFO - warning: no files found matching '*.txt' 01:55:05 INFO - no previously-included directories found matching 'build' 01:55:05 INFO - no previously-included directories found matching 'dist' 01:55:05 INFO - no previously-included directories found matching '.git*' 01:55:05 INFO - Installing collected packages: jsonschema, functools32 01:55:05 INFO - Running setup.py install for functools32 01:55:06 INFO - warning: no files found matching '*.txt' 01:55:06 INFO - no previously-included directories found matching 'build' 01:55:06 INFO - no previously-included directories found matching 'dist' 01:55:06 INFO - no previously-included directories found matching '.git*' 01:55:06 INFO - Successfully installed jsonschema functools32 01:55:06 INFO - Cleaning up... 01:55:06 INFO - Return code: 0 01:55:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:55:06 INFO - Using env: {'DISPLAY': ':0', 01:55:06 INFO - 'HOME': '/home/cltbld', 01:55:06 INFO - 'LANG': 'en_US.UTF-8', 01:55:06 INFO - 'LANGUAGE': 'en_US:en', 01:55:06 INFO - 'LOGNAME': 'cltbld', 01:55:06 INFO - 'MAIL': '/var/mail/cltbld', 01:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:06 INFO - 'MOZ_NO_REMOTE': '1', 01:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:06 INFO - 'NO_EM_RESTART': '1', 01:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:06 INFO - 'PWD': '/builds/slave/test', 01:55:06 INFO - 'SHELL': '/bin/bash', 01:55:06 INFO - 'SHLVL': '1', 01:55:06 INFO - 'TERM': 'linux', 01:55:06 INFO - 'TMOUT': '86400', 01:55:06 INFO - 'USER': 'cltbld', 01:55:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:06 INFO - '_': '/tools/buildbot/bin/python'} 01:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:55:06 INFO - Cleaning up... 01:55:06 INFO - Return code: 0 01:55:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:55:06 INFO - Using env: {'DISPLAY': ':0', 01:55:06 INFO - 'HOME': '/home/cltbld', 01:55:06 INFO - 'LANG': 'en_US.UTF-8', 01:55:06 INFO - 'LANGUAGE': 'en_US:en', 01:55:06 INFO - 'LOGNAME': 'cltbld', 01:55:06 INFO - 'MAIL': '/var/mail/cltbld', 01:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:06 INFO - 'MOZ_NO_REMOTE': '1', 01:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:06 INFO - 'NO_EM_RESTART': '1', 01:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:06 INFO - 'PWD': '/builds/slave/test', 01:55:06 INFO - 'SHELL': '/bin/bash', 01:55:06 INFO - 'SHLVL': '1', 01:55:06 INFO - 'TERM': 'linux', 01:55:06 INFO - 'TMOUT': '86400', 01:55:06 INFO - 'USER': 'cltbld', 01:55:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:06 INFO - '_': '/tools/buildbot/bin/python'} 01:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:06 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:08 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:55:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:09 INFO - Downloading docopt-0.6.1.tar.gz 01:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:09 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:09 INFO - Running setup.py install for blobuploader 01:55:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:55:09 INFO - Running setup.py install for requests 01:55:09 INFO - Running setup.py install for docopt 01:55:09 INFO - Successfully installed blobuploader requests docopt 01:55:09 INFO - Cleaning up... 01:55:09 INFO - Return code: 0 01:55:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:09 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')]} 01:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 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')]} 01:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 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 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:09 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 01:55:09 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 01:55:09 INFO - Using env: {'DISPLAY': ':0', 01:55:09 INFO - 'HOME': '/home/cltbld', 01:55:09 INFO - 'LANG': 'en_US.UTF-8', 01:55:09 INFO - 'LANGUAGE': 'en_US:en', 01:55:09 INFO - 'LOGNAME': 'cltbld', 01:55:09 INFO - 'MAIL': '/var/mail/cltbld', 01:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:09 INFO - 'MOZ_NO_REMOTE': '1', 01:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:09 INFO - 'NO_EM_RESTART': '1', 01:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:09 INFO - 'PWD': '/builds/slave/test', 01:55:09 INFO - 'SHELL': '/bin/bash', 01:55:09 INFO - 'SHLVL': '1', 01:55:09 INFO - 'TERM': 'linux', 01:55:09 INFO - 'TMOUT': '86400', 01:55:09 INFO - 'USER': 'cltbld', 01:55:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:09 INFO - '_': '/tools/buildbot/bin/python'} 01:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:10 INFO - Running setup.py (path:/tmp/pip-Z6mAQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:10 INFO - Running setup.py (path:/tmp/pip-n2e5l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:10 INFO - Running setup.py (path:/tmp/pip-71ISFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:10 INFO - Running setup.py (path:/tmp/pip-KUvnKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:10 INFO - Running setup.py (path:/tmp/pip-EWpweF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:10 INFO - Running setup.py (path:/tmp/pip-UcAhX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:10 INFO - Running setup.py (path:/tmp/pip-Z5wyVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:10 INFO - Running setup.py (path:/tmp/pip-al9ygk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:10 INFO - Running setup.py (path:/tmp/pip-Kg5TPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:10 INFO - Running setup.py (path:/tmp/pip-qW3qOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:10 INFO - Running setup.py (path:/tmp/pip-pfjxyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:10 INFO - Running setup.py (path:/tmp/pip-L9Gf9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:11 INFO - Running setup.py (path:/tmp/pip-sr7mIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:11 INFO - Running setup.py (path:/tmp/pip-rubDCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:11 INFO - Running setup.py (path:/tmp/pip-FpgZkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:11 INFO - Running setup.py (path:/tmp/pip-D58HXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:11 INFO - Running setup.py (path:/tmp/pip-Lzygeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:55:11 INFO - Running setup.py install for manifestparser 01:55:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for mozcrash 01:55:11 INFO - Running setup.py install for mozdebug 01:55:11 INFO - Running setup.py install for mozdevice 01:55:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for mozfile 01:55:11 INFO - Running setup.py install for mozhttpd 01:55:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozinfo 01:55:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozInstall 01:55:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozleak 01:55:12 INFO - Running setup.py install for mozlog 01:55:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for moznetwork 01:55:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozprocess 01:55:12 INFO - Running setup.py install for mozprofile 01:55:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozrunner 01:55:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozscreenshot 01:55:12 INFO - Running setup.py install for moztest 01:55:13 INFO - Running setup.py install for mozversion 01:55:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:55:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:55:13 INFO - Cleaning up... 01:55:13 INFO - Return code: 0 01:55:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:55:13 INFO - Using env: {'DISPLAY': ':0', 01:55:13 INFO - 'HOME': '/home/cltbld', 01:55:13 INFO - 'LANG': 'en_US.UTF-8', 01:55:13 INFO - 'LANGUAGE': 'en_US:en', 01:55:13 INFO - 'LOGNAME': 'cltbld', 01:55:13 INFO - 'MAIL': '/var/mail/cltbld', 01:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:13 INFO - 'MOZ_NO_REMOTE': '1', 01:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:13 INFO - 'NO_EM_RESTART': '1', 01:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:13 INFO - 'PWD': '/builds/slave/test', 01:55:13 INFO - 'SHELL': '/bin/bash', 01:55:13 INFO - 'SHLVL': '1', 01:55:13 INFO - 'TERM': 'linux', 01:55:13 INFO - 'TMOUT': '86400', 01:55:13 INFO - 'USER': 'cltbld', 01:55:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:13 INFO - '_': '/tools/buildbot/bin/python'} 01:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:13 INFO - Running setup.py (path:/tmp/pip-u0_21X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:13 INFO - Running setup.py (path:/tmp/pip-dmFLak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:13 INFO - Running setup.py (path:/tmp/pip-0dfDnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:13 INFO - Running setup.py (path:/tmp/pip-Svp4JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:13 INFO - Running setup.py (path:/tmp/pip-JxBvPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:13 INFO - Running setup.py (path:/tmp/pip-jpHYOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:13 INFO - Running setup.py (path:/tmp/pip-gSs_Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:13 INFO - Running setup.py (path:/tmp/pip-stzYme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:13 INFO - Running setup.py (path:/tmp/pip-WeqHDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:14 INFO - Running setup.py (path:/tmp/pip-Kj2VwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:14 INFO - Running setup.py (path:/tmp/pip-7QNO9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:14 INFO - Running setup.py (path:/tmp/pip-kOVzyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:14 INFO - Running setup.py (path:/tmp/pip-cFUxFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:14 INFO - Running setup.py (path:/tmp/pip-mSGFHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:14 INFO - Running setup.py (path:/tmp/pip-WXfOsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:14 INFO - Running setup.py (path:/tmp/pip-qnRiTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:14 INFO - Running setup.py (path:/tmp/pip-WXxb7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:55:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:16 INFO - Downloading blessings-1.6.tar.gz 01:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:55:16 INFO - Installing collected packages: blessings 01:55:16 INFO - Running setup.py install for blessings 01:55:16 INFO - Successfully installed blessings 01:55:16 INFO - Cleaning up... 01:55:16 INFO - Return code: 0 01:55:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:55:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:17 INFO - Reading from file tmpfile_stdout 01:55:17 INFO - Current package versions: 01:55:17 INFO - argparse == 1.2.1 01:55:17 INFO - blessings == 1.6 01:55:17 INFO - blobuploader == 1.2.4 01:55:17 INFO - docopt == 0.6.1 01:55:17 INFO - functools32 == 3.2.3-2 01:55:17 INFO - jsonschema == 2.5.1 01:55:17 INFO - manifestparser == 1.1 01:55:17 INFO - mozInstall == 1.12 01:55:17 INFO - mozcrash == 1.0 01:55:17 INFO - mozdebug == 0.1 01:55:17 INFO - mozdevice == 0.49 01:55:17 INFO - mozfile == 1.2 01:55:17 INFO - mozhttpd == 0.7 01:55:17 INFO - mozinfo == 0.9 01:55:17 INFO - mozleak == 0.1 01:55:17 INFO - mozlog == 3.4 01:55:17 INFO - moznetwork == 0.27 01:55:17 INFO - mozprocess == 0.24 01:55:17 INFO - mozprofile == 0.28 01:55:17 INFO - mozrunner == 6.13 01:55:17 INFO - mozscreenshot == 0.1 01:55:17 INFO - mozsystemmonitor == 0.3 01:55:17 INFO - moztest == 0.8 01:55:17 INFO - mozversion == 1.4 01:55:17 INFO - psutil == 3.1.1 01:55:17 INFO - requests == 1.2.3 01:55:17 INFO - wsgiref == 0.1.2 01:55:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:55:17 INFO - Using env: {'DISPLAY': ':0', 01:55:17 INFO - 'HOME': '/home/cltbld', 01:55:17 INFO - 'LANG': 'en_US.UTF-8', 01:55:17 INFO - 'LANGUAGE': 'en_US:en', 01:55:17 INFO - 'LOGNAME': 'cltbld', 01:55:17 INFO - 'MAIL': '/var/mail/cltbld', 01:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:17 INFO - 'MOZ_NO_REMOTE': '1', 01:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:17 INFO - 'NO_EM_RESTART': '1', 01:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:17 INFO - 'PWD': '/builds/slave/test', 01:55:17 INFO - 'SHELL': '/bin/bash', 01:55:17 INFO - 'SHLVL': '1', 01:55:17 INFO - 'TERM': 'linux', 01:55:17 INFO - 'TMOUT': '86400', 01:55:17 INFO - 'USER': 'cltbld', 01:55:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:17 INFO - '_': '/tools/buildbot/bin/python'} 01:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:55:17 INFO - Cleaning up... 01:55:17 INFO - Return code: 0 01:55:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', '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 01:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:55:17 INFO - Using env: {'DISPLAY': ':0', 01:55:17 INFO - 'HOME': '/home/cltbld', 01:55:17 INFO - 'LANG': 'en_US.UTF-8', 01:55:17 INFO - 'LANGUAGE': 'en_US:en', 01:55:17 INFO - 'LOGNAME': 'cltbld', 01:55:17 INFO - 'MAIL': '/var/mail/cltbld', 01:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:17 INFO - 'MOZ_NO_REMOTE': '1', 01:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:17 INFO - 'NO_EM_RESTART': '1', 01:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:17 INFO - 'PWD': '/builds/slave/test', 01:55:17 INFO - 'SHELL': '/bin/bash', 01:55:17 INFO - 'SHLVL': '1', 01:55:17 INFO - 'TERM': 'linux', 01:55:17 INFO - 'TMOUT': '86400', 01:55:17 INFO - 'USER': 'cltbld', 01:55:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:17 INFO - '_': '/tools/buildbot/bin/python'} 01:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:55:17 INFO - Cleaning up... 01:55:17 INFO - Return code: 0 01:55:17 INFO - Running post-action listener: _resource_record_post_action 01:55:17 INFO - Running post-action listener: _start_resource_monitoring 01:55:17 INFO - Starting resource monitoring. 01:55:17 INFO - [mozharness: 2017-01-10 09:55:17.625781Z] Finished create-virtualenv step (success) 01:55:17 INFO - [mozharness: 2017-01-10 09:55:17.626326Z] Running install step. 01:55:17 INFO - Running pre-action listener: _resource_record_pre_action 01:55:17 INFO - Running main action method: install 01:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:17 INFO - Reading from file tmpfile_stdout 01:55:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:55:17 INFO - Reading from file tmpfile_stdout 01:55:17 INFO - Output received: 01:55:17 INFO - Usage: mozinstall [options] installer 01:55:17 INFO - Options: 01:55:17 INFO - -h, --help show this help message and exit 01:55:17 INFO - -d DEST, --destination=DEST 01:55:17 INFO - Directory to install application into. [default: 01:55:17 INFO - "/builds/slave/test"] 01:55:17 INFO - --app=APP Application being installed. [default: firefox] 01:55:17 INFO - mkdir: /builds/slave/test/build/application 01:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:55:34 INFO - Reading from file tmpfile_stdout 01:55:34 INFO - Output received: 01:55:34 INFO - /builds/slave/test/build/application/firefox/firefox 01:55:34 INFO - Running post-action listener: _resource_record_post_action 01:55:34 INFO - [mozharness: 2017-01-10 09:55:34.086251Z] Finished install step (success) 01:55:34 INFO - [mozharness: 2017-01-10 09:55:34.086531Z] Running run-tests step. 01:55:34 INFO - Running pre-action listener: _resource_record_pre_action 01:55:34 INFO - Running main action method: run_tests 01:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:55:34 INFO - Python 2.7.3 01:55:34 INFO - Return code: 0 01:55:34 INFO - grabbing minidump binary from tooltool 01:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d03f0>, '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 0x26d0cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d11a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:55:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:55:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:55:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:55:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:55:34 INFO - Return code: 0 01:55:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:55:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:55:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:55:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:55:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:55:34 INFO - Using env: {'DISPLAY': ':0', 01:55:34 INFO - 'HOME': '/home/cltbld', 01:55:34 INFO - 'LANG': 'en_US.UTF-8', 01:55:34 INFO - 'LANGUAGE': 'en_US:en', 01:55:34 INFO - 'LOGNAME': 'cltbld', 01:55:34 INFO - 'MAIL': '/var/mail/cltbld', 01:55:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:55:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:34 INFO - 'MOZ_NO_REMOTE': '1', 01:55:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:55:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:34 INFO - 'NO_EM_RESTART': '1', 01:55:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:34 INFO - 'PWD': '/builds/slave/test', 01:55:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:55:34 INFO - 'SHELL': '/bin/bash', 01:55:34 INFO - 'SHLVL': '1', 01:55:34 INFO - 'TERM': 'linux', 01:55:34 INFO - 'TMOUT': '86400', 01:55:34 INFO - 'USER': 'cltbld', 01:55:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223', 01:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:34 INFO - '_': '/tools/buildbot/bin/python'} 01:55:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:55:34 INFO - mozversion application_buildid: 20170110091743 01:55:34 INFO - mozversion application_changeset: a61edc75cfb522ad1a87bb2be1e1419049361ac4 01:55:34 INFO - mozversion application_display_name: Nightly 01:55:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:55:34 INFO - mozversion application_name: Firefox 01:55:34 INFO - mozversion application_remotingname: firefox 01:55:34 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 01:55:34 INFO - mozversion application_vendor: Mozilla 01:55:34 INFO - mozversion application_version: 53.0a1 01:55:34 INFO - mozversion platform_buildid: 20170110091743 01:55:34 INFO - mozversion platform_changeset: a61edc75cfb522ad1a87bb2be1e1419049361ac4 01:55:34 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 01:55:34 INFO - mozversion platform_version: 53.0a1 01:55:34 INFO - using testdate: 1484042134 01:55:34 INFO - actual date: 1484042134 01:55:34 INFO - starting webserver on 'localhost:52356' 01:55:34 INFO - SUITE-START | Running 2 tests 01:55:34 INFO - TEST-START | dromaeo_css 01:55:34 INFO - operating with platform_type : linux_ 01:55:34 INFO - Initialising browser for dromaeo_css test... 01:55:34 INFO - TEST-INFO | started process 22239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkEAvbM/profile http://localhost:52356/getInfo.html) 01:55:34 INFO - PROCESS | 22239 | 1484042134893 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 01:55:39 INFO - PROCESS | 22239 | __metrics Screen width/height:1600/1200 01:55:39 INFO - PROCESS | 22239 | colorDepth:24 01:55:39 INFO - PROCESS | 22239 | Browser inner width/height: 1024/697 01:55:39 INFO - PROCESS | 22239 | __metrics 01:55:39 ERROR - PROCESS | 22239 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 01:55:40 INFO - TEST-INFO | 22239: exit 0 01:55:40 INFO - Browser initialized. 01:55:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:55:40 INFO - TEST-INFO | started process 22359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkEAvbM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:55:52 INFO - PROCESS | 22359 | RSS: Main: 158892032 01:55:52 INFO - PROCESS | 22359 | 01:58:57 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:52356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52356/tests/dromaeo/cssquery-ext.html) 01:58:58 INFO - PROCESS | 22359 | RSS: Main: 167170048 01:58:58 INFO - PROCESS | 22359 | 02:00:41 INFO - PROCESS | 22359 | ************************* 02:00:41 INFO - PROCESS | 22359 | A coding exception was thrown and uncaught in a Task. 02:00:41 INFO - PROCESS | 22359 | 02:00:41 INFO - PROCESS | 22359 | Full message: ReferenceError: fetch is not defined 02:00:41 INFO - PROCESS | 22359 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 02:00:41 INFO - PROCESS | 22359 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 02:00:41 INFO - PROCESS | 22359 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 02:00:41 INFO - PROCESS | 22359 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:00:41 INFO - PROCESS | 22359 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:00:41 INFO - PROCESS | 22359 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:00:41 INFO - PROCESS | 22359 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 02:00:41 INFO - PROCESS | 22359 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:00:41 INFO - PROCESS | 22359 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:00:41 INFO - PROCESS | 22359 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:00:41 INFO - PROCESS | 22359 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 02:00:41 INFO - PROCESS | 22359 | 02:00:41 INFO - PROCESS | 22359 | ************************* 02:02:01 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:52356/tests/dromaeo/cssquery-ext.html (next: http://localhost:52356/tests/dromaeo/cssquery-jquery.html) 02:02:01 INFO - PROCESS | 22359 | RSS: Main: 163483648 02:02:01 INFO - PROCESS | 22359 | 02:05:03 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:52356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52356/tests/dromaeo/cssquery-mootools.html) 02:05:04 INFO - PROCESS | 22359 | RSS: Main: 168464384 02:05:04 INFO - PROCESS | 22359 | 02:08:06 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:52356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52356/tests/dromaeo/cssquery-prototype.html) 02:08:07 INFO - PROCESS | 22359 | RSS: Main: 163885056 02:08:07 INFO - PROCESS | 22359 | 02:11:10 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:52356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52356/tests/dromaeo/cssquery-yui.html) 02:11:10 INFO - PROCESS | 22359 | RSS: Main: 166952960 02:11:10 INFO - PROCESS | 22359 | 02:14:13 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:52356/tests/dromaeo/cssquery-yui.html (next: http://localhost:52356/tests/dromaeo/cssquery-dojo.html) 02:14:14 INFO - PROCESS | 22359 | RSS: Main: 167534592 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | __start_tp_report 02:14:14 INFO - PROCESS | 22359 | _x_x_mozilla_page_load 02:14:14 INFO - PROCESS | 22359 | _x_x_mozilla_page_load_details 02:14:14 INFO - PROCESS | 22359 | |i|pagename|runs| 02:14:14 INFO - PROCESS | 22359 | |0;dojo.html;2639.472105578884;2642.682878054634;2644.04814266864;2661.880215390307;2670.185593394015;4799.688020278684;4810.39870016248;4828.396450443694;4832.347633069535;4833.78247978841;4762.261849413338;4768.403949506312;4769.952300476994;4790.976045119778;4887.242477415997;4388.144311859189;4421.314696222091;4441.800118994637;4492.775361231942;4553.317002449642;4047.8380864765372;4492.415985921825;4502.48221454532;4514.142312960544;4531;4359.04101097758;4476.149531588988;4486.394336764528;4503.166914120898;4589.105124500724;4382.2331092059085;4426.490953540352;4436.711613745097;4446;4447.79984900677;4387.758673272969;4397.978010109961;4419.756913369763;4422.358757980075;4428.800703968329;4791.856244312677;4795.304680821261;4801.639877009204;4813.711177329372;4826.420829500447;5143.537081662668;5189.325387699575;5196.29849970253;5197.688138711689;5204.167333226704;5224.764885580158;5244.344456942882;5245.134552798783;5248.107821670325;5253.343332083489;4895.143349913751;4895.388076490439;4897.265410188429;4900.460949295611;4903.583195428429;5238.188080847474;5275.894482110413;5284.233786100994;5341.225522299244;5348.759305831247;5107.87230319245;5133.640645154878;5136.126858434075;5138.126518491866;5166.767495462713;5115.820946266863;5127.128388174019;5154.819581314636;5162.199859021857;5223.4776522347465;5152.098382782998;5154.613403994716;5162.716050617177;5198.792048318025;5214.322138122096;5112.846614601568;5116.2069879168785;5150.510701483353;5158.277841102249;5170.069387510284;4233.936490952638;4256.3828244904935;4256.57434256578;4347.8260869564865;4386.232409328355;3737.3459644562636;3768.0768211788286;3794.430835374716;3807.2195199983935;3815.6756675682323;4451;4477.104579084196;4484.148011877733;4487.349334346567;4547.977260113745;5201.765920533585;5228.137357335997;5256.26412302278;5269.947300527022;5303.390110137384;4389.473263208435;4500.392447019611;4504.707194032378;4513.480949690762;4557.703749256354;4559.475660299108;4561.338605902126;4587.082583483317;4595.287730401793;4663.790129444115;4797.712137271775;4820.4456487503685;4838.588719958772;4847.297141914473;4876.390451193601;5105.744712764421;5119.974400127976;5158.638895277295;5179.249008893765;5231.110711179184;4737.573618374363;4783.115123702126;4792.2092854678585;4849.175640141114;4855.441624213261;5087.720175390389;5098.745062746922;5135.178371460548;5144.202648589475;5203.635745497931;5198.376194856642;5212.817551385683;5212.895742085061;5222.686638801684;5270.73646317675;4988.27669987857;5080.745962701776;5087.186050231945;5101.056304583664;5103.10695628271;5025.346704928336;5034.899302014012;5083.034223497523;5083.2883396323805;5161.922571161361;4974.253861920596;4997.9500204997485;5007.1487847065355;5047.268146118866;5099.107656160231;5108.131617625087;5150.1502252127975;5163.948360516347;5166.354205724285;5168.3539557555305;4903.632227583017;4921.9015619688125;4933.210686290176;4949;4992.126377883928 02:14:14 INFO - PROCESS | 22359 | |1;ext.html;499.25510341356966;504.9166887463569;505.2951133169229;520.8880090780482;526.0636067799317;38466.42300365497;40500.797496012514;40509.189816203696;40676.389854152214;40765.388519172164;40563.59436405642;40935.79532102335;41099;41109;41266.38100428496;7648.885266721004;7780;7786.727464538742;7828.099768526636;9560.562056675573;9458.33791634586;9738.853917191247;9763.267754918374;9763.755906102333;9823.65617203398;9854.655087071955;9924.90075099247;9936.105750482455;9941.353812002197;9951.402915825038;9837.065478779505;9839.655612053579;9872.062154095385;9879.555420006118;9900.851487227697;9655.372400793996;9686.564104615309;9697.321187516876;9698.612055517771;9715.514224288758;34919;35050.64949350525;35164.296714065575;35212.29575408503;35213;3674.779513229215;3708.7496965523637;3763.6048214937587;3778.565464971536;3794.4118661607495;24514.14200502974;25560.616590751153;25979;26009.609855852177;26206.606900896502;3250.1874531367157;3299.0267870977877;3301.3892429900543;3383.593968723744;3459.809710465923;222567;223232;224060;224286;225142.87428562916;46935;47142;47193.5280647196;47203.5279647206;47278.76360618244;48314.27528587074;48526.27210591844;48556.5144348552;48790.512094879305;48910.75544622254;13334.333283335794;13875.444982200801;13883.861161388459;13884.861151388357;13914.791278130837;10041.698749037541;10261.692149235534;10768.192385571114;11089.778204435866;11322.660320190407;18889.433317000512;19433.708494372597;19454.70817937732;19485.902570487342;19555.511112222022;7120.9643951780945;7404.261272785422;7639.847203055908;7641.694332226649;7820.139784623801;828.4532208742202;840.5797101449275;844.5861527851431;868.4615538366127;876.0976194519654;27602;27796.444071118465;27980;28042.439151216862;28735.281617959718;991.2862738828032;993.3245393132595;994.1053052252886;1023.6519583341551;1084.0081325587;14593.635159121108;15050.698986020217;15101.924490377698;15314.463993760388;15340.15629140408;342989;343064;344775;344786;346151;51602.22596661053;52182;52216.47783522116;52283.73858130685;52318;1248.606688893014;1279.3731071774764;1294.6180876641413;1296.7212049409422;1309.8362704662109;25965;26938;27666.302018552193;27799.722002779712;27824.72175278302;43209.78395108004;43246.567534324255;43346.133077338905;43351.78324108359;43411.78294108509;295847;297149;297410;297509;297812;23674.171404000776;24228.273151805475;24331.39171520726;25276.87361563254;38434.6156538431;35885;35952.4607130888;36265.818670906476;36330.27339453143;36608.45087323639;30076.39847203;30558;30911.845440772653;31536.526952096196;31696;29850.552241716825;30314.696853031186;30533;30592.235194119436;31705.5244171333;30228.395432091675;30241;30471;30489.390212196075;30628.84685576558;26036.34909127287;27636.170914872586;27862.582061269502;28062;28083.859580701966;21566.689626945157;21811.23660671869;21825.345239642837;21857.125714971222;21860.672089918346 02:14:14 INFO - PROCESS | 22359 | |2;jquery.html;353.67108589012224;373.387644263408;377.347189362403;380.1219183685688;391.03414566021934;16823.915880420594;18010;18316.725249121242;18375.356862509816;18557.07214639266;18078;18262.63474730508;18453.7231941521;18541.16564754586;18636.53408664784;5041.1178043842365;5097.388313402397;5154.716490593016;5161.767720452589;5203.869903252411;4958;5072.365954255718;5101.54086132248;5105.157648987913;5112.539871411572;5035.068512325213;5074.3657042869645;5077.64456488046;5079.111155547765;5082.161443361841;4868.318435419026;5030.421501527335;5063.3417655704525;5063.392392912856;5066.46802085783;4502.2571275739465;4505.36924830524;4522.66080043998;4524.954750452486;4530.252508336121;17885.552861178443;20813.687794683094;20975.539036059185;21033.26383576583;21043.894780526152;2173.2393662218255;2212.9114835406563;2245.303955773715;2245.8203343732625;2258.198339589455;13265.20408775467;13873;13885.305734713325;14152.79701225397;14317.64205894861;1683.2761912377673;1725.1546742096407;1737.0533059482486;1751.9912400438043;1757.5606098475382;70460.2953970464;70883.99999999949;71189;72735;73939.63030184868;9338.766530836783;9532.666356677482;9647.855282170773;9656.37233579815;9917.900820991843;13120.015998799938;13138.802917956238;13188.27464489443;13191.538296159588;13200.20798752078;7140.321669441395;7245.420366370678;7468.066491688539;7481.139668938033;7571.886421703679;6924.757633482804;7078.539894906815;7107.538010029331;7219.278072192844;7277.417806575461;6318.368163183737;6460.353964603596;6460.773872914519;6478.676066196671;6611.438027767597;1737.8088410274859;1747.449553390678;1748.0997286397514;1763.42688626197;1764.5588602849289;872.0886673426158;888.853339199025;905.3888625177979;905.9864102038474;921.3366376209119;16780.58048548796;16813.30876087439;17404.825951740575;17425.390111346296;17784.822151778575;881.797186647062;896.0118006448437;902.2060586683807;904.5070436612062;905.2395987370641;9840.852387214198;9999.250056245664;10175.898241017643;10285.794284114276;10321.483925803679;467763;468966;469493;471414;487541;68080.6595967017;71394.64302678453;73729.63135184397;74017.62991185009;76392.61803691057;931.0875342164582;932.1750251027754;959.4003747657714;962.7159987803615;993.2749093162032;15313.081215127128;16323.673526529641;16360.93653912492;16561.83438165651;16929.830701693318;41490;41672.0557948887;41765.37351939784;42047;42070.78964605158;56683.43316566782;57182;57576;58310.70844645919;59865.401345985985;6403.679816009274;6691.866162676816;6844.98073068456;7025.437964962688;7212.2427145149;8903.866442003246;11693.189878223226;12117.515299388278;12124.818127727915;12174.57388991381;9989.550470228713;10457.529411176363;10488.26582139243;10584.735381615521;10796.298240614335;9025.503597302211;10152.847707284544;10406.47967601632;10751.677449676523;11089.833652495057;9805.2646051545;10057.597696092074;10202.38785672862;10303;10311.948440257751;7665.118511371264;7751.573663448565;7804.453688241769;7835.041239690077;7846.411519136202;8489.575521224038;9803.117719405287;9873.950630246803;9937.950310248692;10204 02:14:14 INFO - PROCESS | 22359 | |3;mootools.html;1302.713403051329;1342.6777573382387;1345.551097003453;1347.9595612131627;1360.2382665707207;6436.581622194554;6667.833304167399;6901.68942397592;7261.745838895639;7415.5921424321705;6914.412274956622;7087.078679771623;7093.14882214135;7262.20115787263;7370.041894553714;2086.561822017374;2128.7977642123974;2131.7015617813518;2133.807957283844;2138.3691810915816;2079.2514694709894;2111.356036408895;2113.6406810842195;2115.0059472048188;2141.2077531313435;2093.675480300556;2137.3053757528787;2144.04589957469;2149.279991202949;2157.85973911696;2072.83417326615;2076.2317942361274;2077.4702450875006;2079.781622929586;2095.140992193201;2140.272307415486;2149.0544160569298;2157.374361435182;2160.9243676471406;2185.5628874225217;7248.492605517616;7263.527870688388;7276.563406195645;7279.67241474135;7400.185979542246;4478.57453541913;4515.4129963104915;4518.277075667877;4542.159700455393;4546.8863278417975;2671.8129730918845;2796.24501384625;2851.6720577133688;2868.0822136915986;2875.9424811503654;1084.967450976472;1088.4013792414141;1115.3753897817166;1127.312339472921;1134.353418551426;9238.214751746042;9282.071792820663;9339.626414943394;9379.062093790635;9545.665901693408;3702.4816525686424;3817.7900215487857;3851.9037024074064;3908.5309762828074;3973.8807835764974;7619.885701714478;7657.234276572298;7791;7832.725854595175;7838.529688218725;4390.034192477649;4391.934120988188;4392.758398288125;4434.17967675981;4462.866114016585;3994.980025099856;4072.083781149218;4076.735012224196;4089.9386509202386;4095.8566450174103;3138.5292206169256;3210.7912985655857;3266.2977459846247;3273.1162586102096;3303.2072302647193;915.6703586708779;948.8624149498285;974.9025097490194;981.7741919358588;996.6960077176531;644.411525589415;656.8587753632992;659.1167835100988;660.075893748746;770.7495064104077;4562.703424277478;4628.282616194495;4636.374089497942;4748.026654535812;4862.319275301461;890.4434728294816;902.7881689859738;916.3722849847876;922.9307801914883;937.254882368505;3089.4747892857818;3121.3289142833946;3129.2020534763947;3187.8406079695924;3236.7989766958694;8018.679252829938;8254.42219044661;8349.29031032357;8579.356548258906;8583.828323433496;8427.789305267417;8489.235968762718;8505.362097842686;8512.148785121439;8529.957350213333;6718.697658605374;6809.93190068093;6817.659117044128;6818.795436136924;6832.555883867532;4816.397950256218;4881.857652272173;4917.9016419672125;4959.504049595156;5060.974695126501;7775.961120194589;7884.566348850868;7936.127026027017;7951.3638908886;7999.080105787909;7955.721549745731;7976.242256985577;8016.9198308016175;8046.678132874619;8153.22544358285;6076.118962750465;6124.142620033288;6200.038993955944;6223.190985171898;6268.091126786681;6726.8990965136545;6727.529072964846;6756.324367563205;6765.695543700447;6897.517173797786;6175.6699383132645;6243.500519958483;6250.3749625037135;6304.243490781136;6395.328490508616;6199.008158694587;6275.215598050244;6276;6322.430981211713;6339.651319177305;5296.099663057213;5428.782848686008;5483.890322193454;5759.65442073477;5879.323877754113;3981.124152686404;4052.2908491013363;4079.224947260011;4095.201435720006;4108.897277568085;4081.7959102044183;4135.441715368507;4164.8334066637;4201.810918508736;4215.768132752605 02:14:14 INFO - PROCESS | 22359 | |4;prototype.html;345.6370810648818;349.9545059142311;352.87296573233647;354.2136457065315;357.4316836230393;5015.172496538067;5023.2465130230485;5047.823326183584;5071.1886098224295;5074.949250507494;4967.528084831944;4980.651354405184;4983.7508124593805;4990.550850423461;5003.646827260289;3766.3597188477956;3804.524434445694;3868.535775706905;3902.9604359487935;3950.044727859699;3895.5714871364125;3941.4876066111365;3944.3689009758446;3944.9013774655577;3946.565877753445;3915.9021024474473;3956.287868183726;3959.98020009901;3963.2271707017144;3973.3245348290716;3623;3826.885193444201;3967.4842270504937;3982.1174355003927;3994.3209654358684;3332.4001679697644;3345.448001079819;3351.312980838922;3359.227377703142;3373.510840928076;4809.182438985381;4810.6873053251775;4814.181589129857;4843.733594652293;4864;4302.397664326997;4355.346697995326;4362.149380870732;4367.497737760166;4377.627901628365;4966.55301022906;5186;5199.558037566811;5202.479752024805;5208.661437006583;3659.2864391443677;3662.816859157058;3662.816859157058;3670.229251857113;3686.594474607791;5450.700211488366;5469.617126801126;5483.725813709339;5485.369182543979;5515.420880807497;3628.745987780883;3661.2677464507206;3707.295613833363;3714.517112775322;3737.4767532545466;3748.156664750409;3766.5856755756845;3774.2828862516585;3776.9433458498142;3785.73499855013;4306.66493387051;4310.418093557392;4328.5455027222315;4346.695731298842;4348.7390756554705;5086.237064440364;5183.377994640668;5207.713575753294;5222.791088356499;5236.764345604457;1250.737345157509;1262.5770366927181;1269.720661454497;1271.5676669932268;1273.3251376770327;819.332244220958;848.2832006954114;853;861.401326078382;862.7066797288826;4438.759705415;4566.520515345907;4574.353232836176;4592.10453961481;4604.470485894098;5407.459254074561;5413.512783849473;5420.105682562333;5432.864178395493;5446.455354464601;4493.977530112394;4577.267637178035;4585.358049873021;4588.334691469719;4603.767172921131;2791.595218693278;2796.314902848774;2808.6208361871295;2816.6197563329097;2827.1482179172676;4922.252600326832;4924.749665220937;4947.060058588929;4970.975145124251;4999.650094474544;5078.648092259091;5367.007103685831;5398.352197736297;5436.755346009439;5443.318745878541;4877.5366340197625;4887.900222449849;4933.407991041026;4957.958828646025;4977.352944117241;5190.429052804264;5212.166053431432;5222.503862133091;5245.763940622604;5302.469753024667;4984.850454486371;5172.482751724798;5200.583953283804;5201.982849947098;5209.01028804526;4927.655064145475;4939.580135688507;4941.135301322182;4964.478729733326;4966.925496117633;3679.9448008280433;3695.3186300233865;3695.5934847167327;3698.7410881238056;3700.7964561948274;4996.875078122931;5202.531772140525;5281.339832520935;5356.196570514454;5370.436104209002;5048.974755126348;5056.342675452168;5061.924071138862;5073.264376665289;5089.6691715038405;5050.868461553713;5060.924086138784;5132.486751324837;5135.563477104488;5149.639525233348;4906.460289368238;4923.778429970588;5074.5940324774665;5089.618278629192;5095.184770436712;4967.677100988424;5030.773615187252;5071.923921141112;5098.668586541863;5154.768035438339;5049.2173713074535;5094.2358646203365;5106.897862042664;5116.616253780907;5119.513646203604 02:14:14 INFO - PROCESS | 22359 | |5;yui.html;636.6021236727046;644.9742010319587;718.4214573834179;779.392074182138;786.8150984518637;12537.498500059997;13393.330333483324;13443.462261509552;13454.663633409169;13564.660883477905;13936.930315348434;14054.156750594972;14304.284785760696;15153.318100685468;15211.847881521182;792.7027364738224;809.134226377776;809.5466538738295;810.8986376702912;812.760235730461;771.965261563231;799.1568894815966;801.3829351399419;815.1848151848152;817.4237162800241;842.0568962761715;842.7429633961639;843.6035063520167;843.7763992541982;845.0662018469595;825.3232349473465;830.3772170871846;830.5390508267909;839.7942504086477;842.9114942930996;614.0512907557834;614.5575185866169;614.7325913227716;615.2616859768251;616.2881871438495;13961.162330260115;14112.364943577564;14265.215413152273;14281.428742850274;14299.714005719932;11954.342511161884;12181.878181218251;12217.450214740358;12333.753324933541;13394.598162055154;10640.414777187252;10668.093212076983;10735.926407359202;10829.566817327297;10912.781744365067;3180.2844360019044;3190.8245046522434;3208.566843476124;3216.549683044352;3248.740100791931;51741.2238816418;52274.21588676135;59809.70095149496;60736.39263607351;60937.6953115236;10311.587536498606;10334.844977325347;10388.272820902464;10463.895361046445;10567.365958042543;18871.150798214112;18884.43346699601;18889.244430222912;18967;18999;6986.755463558751;7112.893306600405;7128;7150.785476435715;7319.341259286583;3794.165283637595;3844.442555829389;3876.5154355705536;3902.083010492532;3954.4859168308512;2951.631046119235;3333.0834020644515;3498.352804731133;3524.54180956474;3538.4692296155267;561.0826299001162;561.9772014932864;566.6911533214408;567.7899177304341;587.9265091863517;624.487919905673;647.0843756085087;650.8340373204898;658.2857599504591;667.519386042049;9119.361644684808;9148.359614827032;9245.861312080324;9374.437533747861;9563.139317461322;578.5082679722202;583.1398686936734;596.5376832954408;600.1537831657342;609.9359567245375;4198.580141985838;4233.5554766749665;4343.087951530151;4438.356438316426;4463.4420697412825;49387.50612493901;57649.71175144098;60946.695266523384;65339;65590.34409655938;55994;56054.71972640192;56990.715046424506;56992.43007569954;58912.410875891546;51491.48508514942;51836.74081629568;52046.47953520492;52532.737336313076;52777.2083418749;7949.7217597383815;8318;8352.582370881553;8385.32917366597;8514.78713032179;35274.823625881705;35578;35924.20378981093;37544.81227593844;37777.62222377741;43995.56004439915;44019;44139.55860441354;44545.55454445414;46029.539704602525;9989.60041598328;10195.235357348376;10281.434521101412;10290.434026128336;10330.070293673305;11526.88473115258;11593.130515211562;11914.10644201671;12600.87399125997;12622.621321360373;10650.520726567169;10877.782444351227;10886.129109671048;11404.600838970928;11455.484503197542;10954.507047183055;11300.152488563226;11600.709982250173;11626.244294120856;11663.125265605284;10446.373217606968;10774.191935605018;10890.727731806768;11247.381394023407;11279.830802537805;9572.234221262142;9653.613855445985;9847.507624618884;10003.649872254437;10155.949220253851;8546.658133674831;9062.184403403726;9109.22571581423;9119.270458363182;9195.356325057182 02:14:14 INFO - PROCESS | 22359 | __end_tp_report 02:14:14 INFO - PROCESS | 22359 | __start_cc_report 02:14:14 INFO - PROCESS | 22359 | _x_x_mozilla_cycle_collect,343 02:14:14 INFO - PROCESS | 22359 | __end_cc_report 02:14:14 INFO - PROCESS | 22359 | __startTimestamp1484043254160__endTimestamp 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | ------- Summary: start ------- 02:14:14 INFO - PROCESS | 22359 | Number of tests: 6 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | [#0] dojo.html Cycles:165 Average:4783.05 Median:4897.27 stddev:521.67 (10.7%) stddev-sans-first:495.43 02:14:14 INFO - PROCESS | 22359 | Values: 2639.5 2642.7 2644.0 2661.9 2670.2 4799.7 4810.4 4828.4 4832.3 4833.8 4762.3 4768.4 4770.0 4791.0 4887.2 4388.1 4421.3 4441.8 4492.8 4553.3 4047.8 4492.4 4502.5 4514.1 4531.0 4359.0 4476.1 4486.4 4503.2 4589.1 4382.2 4426.5 4436.7 4446.0 4447.8 4387.8 4398.0 4419.8 4422.4 4428.8 4791.9 4795.3 4801.6 4813.7 4826.4 5143.5 5189.3 5196.3 5197.7 5204.2 5224.8 5244.3 5245.1 5248.1 5253.3 4895.1 4895.4 4897.3 4900.5 4903.6 5238.2 5275.9 5284.2 5341.2 5348.8 5107.9 5133.6 5136.1 5138.1 5166.8 5115.8 5127.1 5154.8 5162.2 5223.5 5152.1 5154.6 5162.7 5198.8 5214.3 5112.8 5116.2 5150.5 5158.3 5170.1 4233.9 4256.4 4256.6 4347.8 4386.2 3737.3 3768.1 3794.4 3807.2 3815.7 4451.0 4477.1 4484.1 4487.3 4548.0 5201.8 5228.1 5256.3 5269.9 5303.4 4389.5 4500.4 4504.7 4513.5 4557.7 4559.5 4561.3 4587.1 4595.3 4663.8 4797.7 4820.4 4838.6 4847.3 4876.4 5105.7 5120.0 5158.6 5179.2 5231.1 4737.6 4783.1 4792.2 4849.2 4855.4 5087.7 5098.7 5135.2 5144.2 5203.6 5198.4 5212.8 5212.9 5222.7 5270.7 4988.3 5080.7 5087.2 5101.1 5103.1 5025.3 5034.9 5083.0 5083.3 5161.9 4974.3 4998.0 5007.1 5047.3 5099.1 5108.1 5150.2 5163.9 5166.4 5168.4 4903.6 4921.9 4933.2 4949.0 4992.1 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | [#1] ext.html Cycles:180 Average:43971.14 Median:190535.00 stddev:76745.81 (40.3%) stddev-sans-first:76891.70 02:14:14 INFO - PROCESS | 22359 | Values: 499.3 504.9 505.3 520.9 526.1 38466.4 40500.8 40509.2 40676.4 40765.4 40563.6 40935.8 41099.0 41109.0 41266.4 7648.9 7780.0 7786.7 7828.1 9560.6 9458.3 9738.9 9763.3 9763.8 9823.7 9854.7 9924.9 9936.1 9941.4 9951.4 9837.1 9839.7 9872.1 9879.6 9900.9 9655.4 9686.6 9697.3 9698.6 9715.5 34919.0 35050.6 35164.3 35212.3 35213.0 3674.8 3708.7 3763.6 3778.6 3794.4 24514.1 25560.6 25979.0 26009.6 26206.6 3250.2 3299.0 3301.4 3383.6 3459.8 222567.0 223232.0 224060.0 224286.0 225142.9 46935.0 47142.0 47193.5 47203.5 47278.8 48314.3 48526.3 48556.5 48790.5 48910.8 13334.3 13875.4 13883.9 13884.9 13914.8 10041.7 10261.7 10768.2 11089.8 11322.7 18889.4 19433.7 19454.7 19485.9 19555.5 7121.0 7404.3 7639.8 7641.7 7820.1 828.5 840.6 844.6 868.5 876.1 27602.0 27796.4 27980.0 28042.4 28735.3 991.3 993.3 994.1 1023.7 1084.0 14593.6 15050.7 15101.9 15314.5 15340.2 342989.0 343064.0 344775.0 344786.0 346151.0 51602.2 52182.0 52216.5 52283.7 52318.0 1248.6 1279.4 1294.6 1296.7 1309.8 25965.0 26938.0 27666.3 27799.7 27824.7 43209.8 43246.6 43346.1 43351.8 43411.8 295847.0 297149.0 297410.0 297509.0 297812.0 23674.2 24228.3 24331.4 25276.9 38434.6 35885.0 35952.5 36265.8 36330.3 36608.5 30076.4 30558.0 30911.8 31536.5 31696.0 29850.6 30314.7 30533.0 30592.2 31705.5 30228.4 30241.0 30471.0 30489.4 30628.8 26036.3 27636.2 27862.6 28062.0 28083.9 21566.7 21811.2 21825.3 21857.1 21860.7 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | [#2] jquery.html Cycles:180 Average:27100.62 Median:246249.50 stddev:77690.10 (31.5%) stddev-sans-first:77882.08 02:14:14 INFO - PROCESS | 22359 | Values: 353.7 373.4 377.3 380.1 391.0 16823.9 18010.0 18316.7 18375.4 18557.1 18078.0 18262.6 18453.7 18541.2 18636.5 5041.1 5097.4 5154.7 5161.8 5203.9 4958.0 5072.4 5101.5 5105.2 5112.5 5035.1 5074.4 5077.6 5079.1 5082.2 4868.3 5030.4 5063.3 5063.4 5066.5 4502.3 4505.4 4522.7 4525.0 4530.3 17885.6 20813.7 20975.5 21033.3 21043.9 2173.2 2212.9 2245.3 2245.8 2258.2 13265.2 13873.0 13885.3 14152.8 14317.6 1683.3 1725.2 1737.1 1752.0 1757.6 70460.3 70884.0 71189.0 72735.0 73939.6 9338.8 9532.7 9647.9 9656.4 9917.9 13120.0 13138.8 13188.3 13191.5 13200.2 7140.3 7245.4 7468.1 7481.1 7571.9 6924.8 7078.5 7107.5 7219.3 7277.4 6318.4 6460.4 6460.8 6478.7 6611.4 1737.8 1747.4 1748.1 1763.4 1764.6 872.1 888.9 905.4 906.0 921.3 16780.6 16813.3 17404.8 17425.4 17784.8 881.8 896.0 902.2 904.5 905.2 9840.9 9999.3 10175.9 10285.8 10321.5 467763.0 468966.0 469493.0 471414.0 487541.0 68080.7 71394.6 73729.6 74017.6 76392.6 931.1 932.2 959.4 962.7 993.3 15313.1 16323.7 16360.9 16561.8 16929.8 41490.0 41672.1 41765.4 42047.0 42070.8 56683.4 57182.0 57576.0 58310.7 59865.4 6403.7 6691.9 6845.0 7025.4 7212.2 8903.9 11693.2 12117.5 12124.8 12174.6 9989.6 10457.5 10488.3 10584.7 10796.3 9025.5 10152.8 10406.5 10751.7 11089.8 9805.3 10057.6 10202.4 10303.0 10311.9 7665.1 7751.6 7804.5 7835.0 7846.4 8489.6 9803.1 9874.0 9938.0 10204.0 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | [#3] mootools.html Cycles:180 Average:4684.97 Median:5362.44 stddev:2516.79 (46.9%) stddev-sans-first:2511.02 02:14:14 INFO - PROCESS | 22359 | Values: 1302.7 1342.7 1345.6 1348.0 1360.2 6436.6 6667.8 6901.7 7261.7 7415.6 6914.4 7087.1 7093.1 7262.2 7370.0 2086.6 2128.8 2131.7 2133.8 2138.4 2079.3 2111.4 2113.6 2115.0 2141.2 2093.7 2137.3 2144.0 2149.3 2157.9 2072.8 2076.2 2077.5 2079.8 2095.1 2140.3 2149.1 2157.4 2160.9 2185.6 7248.5 7263.5 7276.6 7279.7 7400.2 4478.6 4515.4 4518.3 4542.2 4546.9 2671.8 2796.2 2851.7 2868.1 2875.9 1085.0 1088.4 1115.4 1127.3 1134.4 9238.2 9282.1 9339.6 9379.1 9545.7 3702.5 3817.8 3851.9 3908.5 3973.9 7619.9 7657.2 7791.0 7832.7 7838.5 4390.0 4391.9 4392.8 4434.2 4462.9 3995.0 4072.1 4076.7 4089.9 4095.9 3138.5 3210.8 3266.3 3273.1 3303.2 915.7 948.9 974.9 981.8 996.7 644.4 656.9 659.1 660.1 770.7 4562.7 4628.3 4636.4 4748.0 4862.3 890.4 902.8 916.4 922.9 937.3 3089.5 3121.3 3129.2 3187.8 3236.8 8018.7 8254.4 8349.3 8579.4 8583.8 8427.8 8489.2 8505.4 8512.1 8530.0 6718.7 6809.9 6817.7 6818.8 6832.6 4816.4 4881.9 4917.9 4959.5 5061.0 7776.0 7884.6 7936.1 7951.4 7999.1 7955.7 7976.2 8016.9 8046.7 8153.2 6076.1 6124.1 6200.0 6223.2 6268.1 6726.9 6727.5 6756.3 6765.7 6897.5 6175.7 6243.5 6250.4 6304.2 6395.3 6199.0 6275.2 6276.0 6322.4 6339.7 5296.1 5428.8 5483.9 5759.7 5879.3 3981.1 4052.3 4079.2 4095.2 4108.9 4081.8 4135.4 4164.8 4201.8 4215.8 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | [#4] prototype.html Cycles:180 Average:4281.69 Median:4926.20 stddev:1243.78 (25.2%) stddev-sans-first:1211.67 02:14:14 INFO - PROCESS | 22359 | Values: 345.6 350.0 352.9 354.2 357.4 5015.2 5023.2 5047.8 5071.2 5074.9 4967.5 4980.7 4983.8 4990.6 5003.6 3766.4 3804.5 3868.5 3903.0 3950.0 3895.6 3941.5 3944.4 3944.9 3946.6 3915.9 3956.3 3960.0 3963.2 3973.3 3623.0 3826.9 3967.5 3982.1 3994.3 3332.4 3345.4 3351.3 3359.2 3373.5 4809.2 4810.7 4814.2 4843.7 4864.0 4302.4 4355.3 4362.1 4367.5 4377.6 4966.6 5186.0 5199.6 5202.5 5208.7 3659.3 3662.8 3662.8 3670.2 3686.6 5450.7 5469.6 5483.7 5485.4 5515.4 3628.7 3661.3 3707.3 3714.5 3737.5 3748.2 3766.6 3774.3 3776.9 3785.7 4306.7 4310.4 4328.5 4346.7 4348.7 5086.2 5183.4 5207.7 5222.8 5236.8 1250.7 1262.6 1269.7 1271.6 1273.3 819.3 848.3 853.0 861.4 862.7 4438.8 4566.5 4574.4 4592.1 4604.5 5407.5 5413.5 5420.1 5432.9 5446.5 4494.0 4577.3 4585.4 4588.3 4603.8 2791.6 2796.3 2808.6 2816.6 2827.1 4922.3 4924.7 4947.1 4971.0 4999.7 5078.6 5367.0 5398.4 5436.8 5443.3 4877.5 4887.9 4933.4 4958.0 4977.4 5190.4 5212.2 5222.5 5245.8 5302.5 4984.9 5172.5 5200.6 5202.0 5209.0 4927.7 4939.6 4941.1 4964.5 4966.9 3679.9 3695.3 3695.6 3698.7 3700.8 4996.9 5202.5 5281.3 5356.2 5370.4 5049.0 5056.3 5061.9 5073.3 5089.7 5050.9 5060.9 5132.5 5135.6 5149.6 4906.5 4923.8 5074.6 5089.6 5095.2 4967.7 5030.8 5071.9 5098.7 5154.8 5049.2 5094.2 5106.9 5116.6 5119.5 02:14:14 INFO - PROCESS | 22359 | 02:14:14 INFO - PROCESS | 22359 | [#5] yui.html Cycles:180 Average:14498.87 Median:47708.52 stddev:17522.78 (36.7%) stddev-sans-first:17541.02 02:14:14 INFO - PROCESS | 22359 | Values: 636.6 645.0 718.4 779.4 786.8 12537.5 13393.3 13443.5 13454.7 13564.7 13936.9 14054.2 14304.3 15153.3 15211.8 792.7 809.1 809.5 810.9 812.8 772.0 799.2 801.4 815.2 817.4 842.1 842.7 843.6 843.8 845.1 825.3 830.4 830.5 839.8 842.9 614.1 614.6 614.7 615.3 616.3 13961.2 14112.4 14265.2 14281.4 14299.7 11954.3 12181.9 12217.5 12333.8 13394.6 10640.4 10668.1 10735.9 10829.6 10912.8 3180.3 3190.8 3208.6 3216.5 3248.7 51741.2 52274.2 59809.7 60736.4 60937.7 10311.6 10334.8 10388.3 10463.9 10567.4 18871.2 18884.4 18889.2 18967.0 18999.0 6986.8 7112.9 7128.0 7150.8 7319.3 3794.2 3844.4 3876.5 3902.1 3954.5 2951.6 3333.1 3498.4 3524.5 3538.5 561.1 562.0 566.7 567.8 587.9 624.5 647.1 650.8 658.3 667.5 9119.4 9148.4 9245.9 9374.4 9563.1 578.5 583.1 596.5 600.2 609.9 4198.6 4233.6 4343.1 4438.4 4463.4 49387.5 57649.7 60946.7 65339.0 65590.3 55994.0 56054.7 56990.7 56992.4 58912.4 51491.5 51836.7 52046.5 52532.7 52777.2 7949.7 8318.0 8352.6 8385.3 8514.8 35274.8 35578.0 35924.2 37544.8 37777.6 43995.6 44019.0 44139.6 44545.6 46029.5 9989.6 10195.2 10281.4 10290.4 10330.1 11526.9 11593.1 11914.1 12600.9 12622.6 10650.5 10877.8 10886.1 11404.6 11455.5 10954.5 11300.2 11600.7 11626.2 11663.1 10446.4 10774.2 10890.7 11247.4 11279.8 9572.2 9653.6 9847.5 10003.6 10155.9 8546.7 9062.2 9109.2 9119.3 9195.4 02:14:14 INFO - PROCESS | 22359 | -------- Summary: end -------- 02:14:14 INFO - PROCESS | 22359 | 02:14:15 INFO - TEST-INFO | 22359: exit 0 02:14:15 INFO - TEST-OK | dromaeo_css | took 1120672ms 02:14:15 INFO - TEST-START | kraken 02:14:15 INFO - operating with platform_type : linux_ 02:14:15 INFO - Initialising browser for kraken test... 02:14:15 INFO - TEST-INFO | started process 22704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcUmZUS/profile http://localhost:52356/getInfo.html) 02:14:15 INFO - PROCESS | 22704 | 1484043255533 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 02:14:19 INFO - PROCESS | 22704 | __metrics Screen width/height:1600/1200 02:14:19 INFO - PROCESS | 22704 | colorDepth:24 02:14:19 INFO - PROCESS | 22704 | Browser inner width/height: 1024/697 02:14:19 INFO - PROCESS | 22704 | __metrics 02:14:20 ERROR - PROCESS | 22704 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 02:14:21 INFO - TEST-INFO | 22704: exit 0 02:14:21 INFO - Browser initialized. 02:14:21 INFO - Running cycle 1/1 for kraken test... 02:14:21 INFO - TEST-INFO | started process 22825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcUmZUS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:33 INFO - PROCESS | 22825 | RSS: Main: 159358976 02:14:33 INFO - PROCESS | 22825 | 02:14:36 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52356/tests/kraken/driver.html?testName=audio-beat-detection) 02:14:37 INFO - PROCESS | 22825 | RSS: Main: 165502976 02:14:37 INFO - PROCESS | 22825 | 02:14:39 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52356/tests/kraken/driver.html?testName=audio-dft) 02:14:40 INFO - PROCESS | 22825 | RSS: Main: 164507648 02:14:40 INFO - PROCESS | 22825 | 02:14:43 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52356/tests/kraken/driver.html?testName=audio-fft) 02:14:44 INFO - PROCESS | 22825 | RSS: Main: 160538624 02:14:44 INFO - PROCESS | 22825 | 02:14:46 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52356/tests/kraken/driver.html?testName=audio-oscillator) 02:14:46 INFO - PROCESS | 22825 | RSS: Main: 161157120 02:14:46 INFO - PROCESS | 22825 | 02:14:49 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:14:49 INFO - PROCESS | 22825 | RSS: Main: 161554432 02:14:49 INFO - PROCESS | 22825 | 02:14:52 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52356/tests/kraken/driver.html?testName=imaging-darkroom) 02:14:53 INFO - PROCESS | 22825 | RSS: Main: 166002688 02:14:53 INFO - PROCESS | 22825 | 02:14:56 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52356/tests/kraken/driver.html?testName=imaging-desaturate) 02:14:57 INFO - PROCESS | 22825 | RSS: Main: 162856960 02:14:57 INFO - PROCESS | 22825 | 02:15:00 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52356/tests/kraken/driver.html?testName=json-parse-financial) 02:15:01 INFO - PROCESS | 22825 | RSS: Main: 163647488 02:15:01 INFO - PROCESS | 22825 | 02:15:02 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:03 INFO - PROCESS | 22825 | RSS: Main: 163708928 02:15:03 INFO - PROCESS | 22825 | 02:15:05 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:06 INFO - PROCESS | 22825 | RSS: Main: 163422208 02:15:06 INFO - PROCESS | 22825 | 02:15:08 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:08 INFO - PROCESS | 22825 | RSS: Main: 163201024 02:15:08 INFO - PROCESS | 22825 | 02:15:11 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:15:12 INFO - PROCESS | 22825 | RSS: Main: 164786176 02:15:12 INFO - PROCESS | 22825 | 02:15:15 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:15:16 INFO - PROCESS | 22825 | RSS: Main: 164511744 02:15:16 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:52356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52356/tests/kraken/driver.html?testName=ai-astar) 02:15:18 INFO - PROCESS | 22825 | RSS: Main: 166187008 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | __start_tp_report 02:15:18 INFO - PROCESS | 22825 | _x_x_mozilla_page_load 02:15:18 INFO - PROCESS | 22825 | _x_x_mozilla_page_load_details 02:15:18 INFO - PROCESS | 22825 | |i|pagename|runs| 02:15:18 INFO - PROCESS | 22825 | |0;ai-astar;108;115;117;114;116;115;116;117;115;115 02:15:18 INFO - PROCESS | 22825 | |1;audio-beat-detection;154;128;134;184;126;127;127;125;140;125 02:15:18 INFO - PROCESS | 22825 | |2;audio-dft;165;164;165;172;164;166;165;164;163;162 02:15:18 INFO - PROCESS | 22825 | |3;audio-fft;76;78;77;108;78;76;77;76;91;76 02:15:18 INFO - PROCESS | 22825 | |4;audio-oscillator;85;86;112;89;88;89;99;86;87;102 02:15:18 INFO - PROCESS | 22825 | |5;imaging-gaussian-blur;118;118;118;117;118;118;118;118;118;117 02:15:18 INFO - PROCESS | 22825 | |6;imaging-darkroom;151;150;151;151;151;151;151;151;153;151 02:15:18 INFO - PROCESS | 22825 | |7;imaging-desaturate;97;96;96;97;97;96;97;96;97;96 02:15:18 INFO - PROCESS | 22825 | |8;json-parse-financial;65;65;64;66;66;66;66;70;65;66 02:15:18 INFO - PROCESS | 22825 | |9;json-stringify-tinderbox;68;68;67;68;70;70;68;68;67;68 02:15:18 INFO - PROCESS | 22825 | |10;stanford-crypto-aes;96;89;86;85;87;91;91;86;87;88 02:15:18 INFO - PROCESS | 22825 | |11;stanford-crypto-ccm;155;138;146;151;137;140;138;155;197;135 02:15:18 INFO - PROCESS | 22825 | |12;stanford-crypto-pbkdf2;183;190;183;185;186;185;179;182;180;181 02:15:18 INFO - PROCESS | 22825 | |13;stanford-crypto-sha256-iterative;71;71;69;72;71;71;69;74;70;70 02:15:18 INFO - PROCESS | 22825 | __end_tp_report 02:15:18 INFO - PROCESS | 22825 | __start_cc_report 02:15:18 INFO - PROCESS | 22825 | _x_x_mozilla_cycle_collect,812 02:15:18 INFO - PROCESS | 22825 | __end_cc_report 02:15:18 INFO - PROCESS | 22825 | __startTimestamp1484043318291__endTimestamp 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | ------- Summary: start ------- 02:15:18 INFO - PROCESS | 22825 | Number of tests: 14 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:2.57 (2.2%) stddev-sans-first:1.01 02:15:18 INFO - PROCESS | 22825 | Values: 108.0 115.0 117.0 114.0 116.0 115.0 116.0 117.0 115.0 115.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:131.00 stddev:18.87 (14.4%) stddev-sans-first:18.99 02:15:18 INFO - PROCESS | 22825 | Values: 154.0 128.0 134.0 184.0 126.0 127.0 127.0 125.0 140.0 125.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.71 (1.6%) stddev-sans-first:2.87 02:15:18 INFO - PROCESS | 22825 | Values: 165.0 164.0 165.0 172.0 164.0 166.0 165.0 164.0 163.0 162.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:10.42 (13.5%) stddev-sans-first:10.88 02:15:18 INFO - PROCESS | 22825 | Values: 76.0 78.0 77.0 108.0 78.0 76.0 77.0 76.0 91.0 76.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:87.50 stddev:8.99 (10.3%) stddev-sans-first:9.14 02:15:18 INFO - PROCESS | 22825 | Values: 85.0 86.0 112.0 89.0 88.0 89.0 99.0 86.0 87.0 102.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:15:18 INFO - PROCESS | 22825 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:15:18 INFO - PROCESS | 22825 | Values: 151.0 150.0 151.0 151.0 151.0 151.0 151.0 151.0 153.0 151.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:15:18 INFO - PROCESS | 22825 | Values: 97.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 97.0 96.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.60 (2.4%) stddev-sans-first:1.66 02:15:18 INFO - PROCESS | 22825 | Values: 65.0 65.0 64.0 66.0 66.0 66.0 66.0 70.0 65.0 66.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 02:15:18 INFO - PROCESS | 22825 | Values: 68.0 68.0 67.0 68.0 70.0 70.0 68.0 68.0 67.0 68.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.50 stddev:3.31 (3.7%) stddev-sans-first:2.17 02:15:18 INFO - PROCESS | 22825 | Values: 96.0 89.0 86.0 85.0 87.0 91.0 91.0 86.0 87.0 88.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:148.50 stddev:18.41 (12.4%) stddev-sans-first:19.41 02:15:18 INFO - PROCESS | 22825 | Values: 155.0 138.0 146.0 151.0 137.0 140.0 138.0 155.0 197.0 135.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:184.00 stddev:3.24 (1.8%) stddev-sans-first:3.43 02:15:18 INFO - PROCESS | 22825 | Values: 183.0 190.0 183.0 185.0 186.0 185.0 179.0 182.0 180.0 181.0 02:15:18 INFO - PROCESS | 22825 | 02:15:18 INFO - PROCESS | 22825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 02:15:18 INFO - PROCESS | 22825 | Values: 71.0 71.0 69.0 72.0 71.0 71.0 69.0 74.0 70.0 70.0 02:15:18 INFO - PROCESS | 22825 | -------- Summary: end -------- 02:15:18 INFO - PROCESS | 22825 | 02:15:19 INFO - TEST-INFO | 22825: exit 0 02:15:19 INFO - TEST-OK | kraken | took 64389ms 02:15:19 INFO - SUITE-END | took 1185s 02:15:19 INFO - Completed test suite (00:19:45) 02:15:19 INFO - javascript benchmark 02:15:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6358.171145297248, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.472105578884, 2642.682878054634, 2644.04814266864, 2661.880215390307, 2670.185593394015, 4799.688020278684, 4810.39870016248, 4828.396450443694, 4832.347633069535, 4833.78247978841, 4762.261849413338, 4768.403949506312, 4769.952300476994, 4790.976045119778, 4887.242477415997, 4388.144311859189, 4421.314696222091, 4441.800118994637, 4492.775361231942, 4553.317002449642, 4047.8380864765372, 4492.415985921825, 4502.48221454532, 4514.142312960544, 4531.0, 4359.04101097758, 4476.149531588988, 4486.394336764528, 4503.166914120898, 4589.105124500724, 4382.2331092059085, 4426.490953540352, 4436.711613745097, 4446.0, 4447.79984900677, 4387.758673272969, 4397.978010109961, 4419.756913369763, 4422.358757980075, 4428.800703968329, 4791.856244312677, 4795.304680821261, 4801.639877009204, 4813.711177329372, 4826.420829500447, 5143.537081662668, 5189.325387699575, 5196.29849970253, 5197.688138711689, 5204.167333226704, 5224.764885580158, 5244.344456942882, 5245.134552798783, 5248.107821670325, 5253.343332083489, 4895.143349913751, 4895.388076490439, 4897.265410188429, 4900.460949295611, 4903.583195428429, 5238.188080847474, 5275.894482110413, 5284.233786100994, 5341.225522299244, 5348.759305831247, 5107.87230319245, 5133.640645154878, 5136.126858434075, 5138.126518491866, 5166.767495462713, 5115.820946266863, 5127.128388174019, 5154.819581314636, 5162.199859021857, 5223.4776522347465, 5152.098382782998, 5154.613403994716, 5162.716050617177, 5198.792048318025, 5214.322138122096, 5112.846614601568, 5116.2069879168785, 5150.510701483353, 5158.277841102249, 5170.069387510284, 4233.936490952638, 4256.3828244904935, 4256.57434256578, 4347.8260869564865, 4386.232409328355, 3737.3459644562636, 3768.0768211788286, 3794.430835374716, 3807.2195199983935, 3815.6756675682323, 4451.0, 4477.104579084196, 4484.148011877733, 4487.349334346567, 4547.977260113745, 5201.765920533585, 5228.137357335997, 5256.26412302278, 5269.947300527022, 5303.390110137384, 4389.473263208435, 4500.392447019611, 4504.707194032378, 4513.480949690762, 4557.703749256354, 4559.475660299108, 4561.338605902126, 4587.082583483317, 4595.287730401793, 4663.790129444115, 4797.712137271775, 4820.4456487503685, 4838.588719958772, 4847.297141914473, 4876.390451193601, 5105.744712764421, 5119.974400127976, 5158.638895277295, 5179.249008893765, 5231.110711179184, 4737.573618374363, 4783.115123702126, 4792.2092854678585, 4849.175640141114, 4855.441624213261, 5087.720175390389, 5098.745062746922, 5135.178371460548, 5144.202648589475, 5203.635745497931, 5198.376194856642, 5212.817551385683, 5212.895742085061, 5222.686638801684, 5270.73646317675, 4988.27669987857, 5080.745962701776, 5087.186050231945, 5101.056304583664, 5103.10695628271, 5025.346704928336, 5034.899302014012, 5083.034223497523, 5083.2883396323805, 5161.922571161361, 4974.253861920596, 4997.9500204997485, 5007.1487847065355, 5047.268146118866, 5099.107656160231, 5108.131617625087, 5150.1502252127975, 5163.948360516347, 5166.354205724285, 5168.3539557555305, 4903.632227583017, 4921.9015619688125, 4933.210686290176, 4949.0, 4992.126377883928], "value": 4748.311464848666, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.25510341356966, 504.9166887463569, 505.2951133169229, 520.8880090780482, 526.0636067799317, 38466.42300365497, 40500.797496012514, 40509.189816203696, 40676.389854152214, 40765.388519172164, 40563.59436405642, 40935.79532102335, 41099.0, 41109.0, 41266.38100428496, 7648.885266721004, 7780.0, 7786.727464538742, 7828.099768526636, 9560.562056675573, 9458.33791634586, 9738.853917191247, 9763.267754918374, 9763.755906102333, 9823.65617203398, 9854.655087071955, 9924.90075099247, 9936.105750482455, 9941.353812002197, 9951.402915825038, 9837.065478779505, 9839.655612053579, 9872.062154095385, 9879.555420006118, 9900.851487227697, 9655.372400793996, 9686.564104615309, 9697.321187516876, 9698.612055517771, 9715.514224288758, 34919.0, 35050.64949350525, 35164.296714065575, 35212.29575408503, 35213.0, 3674.779513229215, 3708.7496965523637, 3763.6048214937587, 3778.565464971536, 3794.4118661607495, 24514.14200502974, 25560.616590751153, 25979.0, 26009.609855852177, 26206.606900896502, 3250.1874531367157, 3299.0267870977877, 3301.3892429900543, 3383.593968723744, 3459.809710465923, 222567.0, 223232.0, 224060.0, 224286.0, 225142.87428562916, 46935.0, 47142.0, 47193.5280647196, 47203.5279647206, 47278.76360618244, 48314.27528587074, 48526.27210591844, 48556.5144348552, 48790.512094879305, 48910.75544622254, 13334.333283335794, 13875.444982200801, 13883.861161388459, 13884.861151388357, 13914.791278130837, 10041.698749037541, 10261.692149235534, 10768.192385571114, 11089.778204435866, 11322.660320190407, 18889.433317000512, 19433.708494372597, 19454.70817937732, 19485.902570487342, 19555.511112222022, 7120.9643951780945, 7404.261272785422, 7639.847203055908, 7641.694332226649, 7820.139784623801, 828.4532208742202, 840.5797101449275, 844.5861527851431, 868.4615538366127, 876.0976194519654, 27602.0, 27796.444071118465, 27980.0, 28042.439151216862, 28735.281617959718, 991.2862738828032, 993.3245393132595, 994.1053052252886, 1023.6519583341551, 1084.0081325587, 14593.635159121108, 15050.698986020217, 15101.924490377698, 15314.463993760388, 15340.15629140408, 342989.0, 343064.0, 344775.0, 344786.0, 346151.0, 51602.22596661053, 52182.0, 52216.47783522116, 52283.73858130685, 52318.0, 1248.606688893014, 1279.3731071774764, 1294.6180876641413, 1296.7212049409422, 1309.8362704662109, 25965.0, 26938.0, 27666.302018552193, 27799.722002779712, 27824.72175278302, 43209.78395108004, 43246.567534324255, 43346.133077338905, 43351.78324108359, 43411.78294108509, 295847.0, 297149.0, 297410.0, 297509.0, 297812.0, 23674.171404000776, 24228.273151805475, 24331.39171520726, 25276.87361563254, 38434.6156538431, 35885.0, 35952.4607130888, 36265.818670906476, 36330.27339453143, 36608.45087323639, 30076.39847203, 30558.0, 30911.845440772653, 31536.526952096196, 31696.0, 29850.552241716825, 30314.696853031186, 30533.0, 30592.235194119436, 31705.5244171333, 30228.395432091675, 30241.0, 30471.0, 30489.390212196075, 30628.84685576558, 26036.34909127287, 27636.170914872586, 27862.582061269502, 28062.0, 28083.859580701966, 21566.689626945157, 21811.23660671869, 21825.345239642837, 21857.125714971222, 21860.672089918346], "value": 17331.019585861493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.67108589012224, 373.387644263408, 377.347189362403, 380.1219183685688, 391.03414566021934, 16823.915880420594, 18010.0, 18316.725249121242, 18375.356862509816, 18557.07214639266, 18078.0, 18262.63474730508, 18453.7231941521, 18541.16564754586, 18636.53408664784, 5041.1178043842365, 5097.388313402397, 5154.716490593016, 5161.767720452589, 5203.869903252411, 4958.0, 5072.365954255718, 5101.54086132248, 5105.157648987913, 5112.539871411572, 5035.068512325213, 5074.3657042869645, 5077.64456488046, 5079.111155547765, 5082.161443361841, 4868.318435419026, 5030.421501527335, 5063.3417655704525, 5063.392392912856, 5066.46802085783, 4502.2571275739465, 4505.36924830524, 4522.66080043998, 4524.954750452486, 4530.252508336121, 17885.552861178443, 20813.687794683094, 20975.539036059185, 21033.26383576583, 21043.894780526152, 2173.2393662218255, 2212.9114835406563, 2245.303955773715, 2245.8203343732625, 2258.198339589455, 13265.20408775467, 13873.0, 13885.305734713325, 14152.79701225397, 14317.64205894861, 1683.2761912377673, 1725.1546742096407, 1737.0533059482486, 1751.9912400438043, 1757.5606098475382, 70460.2953970464, 70883.99999999949, 71189.0, 72735.0, 73939.63030184868, 9338.766530836783, 9532.666356677482, 9647.855282170773, 9656.37233579815, 9917.900820991843, 13120.015998799938, 13138.802917956238, 13188.27464489443, 13191.538296159588, 13200.20798752078, 7140.321669441395, 7245.420366370678, 7468.066491688539, 7481.139668938033, 7571.886421703679, 6924.757633482804, 7078.539894906815, 7107.538010029331, 7219.278072192844, 7277.417806575461, 6318.368163183737, 6460.353964603596, 6460.773872914519, 6478.676066196671, 6611.438027767597, 1737.8088410274859, 1747.449553390678, 1748.0997286397514, 1763.42688626197, 1764.5588602849289, 872.0886673426158, 888.853339199025, 905.3888625177979, 905.9864102038474, 921.3366376209119, 16780.58048548796, 16813.30876087439, 17404.825951740575, 17425.390111346296, 17784.822151778575, 881.797186647062, 896.0118006448437, 902.2060586683807, 904.5070436612062, 905.2395987370641, 9840.852387214198, 9999.250056245664, 10175.898241017643, 10285.794284114276, 10321.483925803679, 467763.0, 468966.0, 469493.0, 471414.0, 487541.0, 68080.6595967017, 71394.64302678453, 73729.63135184397, 74017.62991185009, 76392.61803691057, 931.0875342164582, 932.1750251027754, 959.4003747657714, 962.7159987803615, 993.2749093162032, 15313.081215127128, 16323.673526529641, 16360.93653912492, 16561.83438165651, 16929.830701693318, 41490.0, 41672.0557948887, 41765.37351939784, 42047.0, 42070.78964605158, 56683.43316566782, 57182.0, 57576.0, 58310.70844645919, 59865.401345985985, 6403.679816009274, 6691.866162676816, 6844.98073068456, 7025.437964962688, 7212.2427145149, 8903.866442003246, 11693.189878223226, 12117.515299388278, 12124.818127727915, 12174.57388991381, 9989.550470228713, 10457.529411176363, 10488.26582139243, 10584.735381615521, 10796.298240614335, 9025.503597302211, 10152.847707284544, 10406.47967601632, 10751.677449676523, 11089.833652495057, 9805.2646051545, 10057.597696092074, 10202.38785672862, 10303.0, 10311.948440257751, 7665.118511371264, 7751.573663448565, 7804.453688241769, 7835.041239690077, 7846.411519136202, 8489.575521224038, 9803.117719405287, 9873.950630246803, 9937.950310248692, 10204.0], "value": 8474.450880910237, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.713403051329, 1342.6777573382387, 1345.551097003453, 1347.9595612131627, 1360.2382665707207, 6436.581622194554, 6667.833304167399, 6901.68942397592, 7261.745838895639, 7415.5921424321705, 6914.412274956622, 7087.078679771623, 7093.14882214135, 7262.20115787263, 7370.041894553714, 2086.561822017374, 2128.7977642123974, 2131.7015617813518, 2133.807957283844, 2138.3691810915816, 2079.2514694709894, 2111.356036408895, 2113.6406810842195, 2115.0059472048188, 2141.2077531313435, 2093.675480300556, 2137.3053757528787, 2144.04589957469, 2149.279991202949, 2157.85973911696, 2072.83417326615, 2076.2317942361274, 2077.4702450875006, 2079.781622929586, 2095.140992193201, 2140.272307415486, 2149.0544160569298, 2157.374361435182, 2160.9243676471406, 2185.5628874225217, 7248.492605517616, 7263.527870688388, 7276.563406195645, 7279.67241474135, 7400.185979542246, 4478.57453541913, 4515.4129963104915, 4518.277075667877, 4542.159700455393, 4546.8863278417975, 2671.8129730918845, 2796.24501384625, 2851.6720577133688, 2868.0822136915986, 2875.9424811503654, 1084.967450976472, 1088.4013792414141, 1115.3753897817166, 1127.312339472921, 1134.353418551426, 9238.214751746042, 9282.071792820663, 9339.626414943394, 9379.062093790635, 9545.665901693408, 3702.4816525686424, 3817.7900215487857, 3851.9037024074064, 3908.5309762828074, 3973.8807835764974, 7619.885701714478, 7657.234276572298, 7791.0, 7832.725854595175, 7838.529688218725, 4390.034192477649, 4391.934120988188, 4392.758398288125, 4434.17967675981, 4462.866114016585, 3994.980025099856, 4072.083781149218, 4076.735012224196, 4089.9386509202386, 4095.8566450174103, 3138.5292206169256, 3210.7912985655857, 3266.2977459846247, 3273.1162586102096, 3303.2072302647193, 915.6703586708779, 948.8624149498285, 974.9025097490194, 981.7741919358588, 996.6960077176531, 644.411525589415, 656.8587753632992, 659.1167835100988, 660.075893748746, 770.7495064104077, 4562.703424277478, 4628.282616194495, 4636.374089497942, 4748.026654535812, 4862.319275301461, 890.4434728294816, 902.7881689859738, 916.3722849847876, 922.9307801914883, 937.254882368505, 3089.4747892857818, 3121.3289142833946, 3129.2020534763947, 3187.8406079695924, 3236.7989766958694, 8018.679252829938, 8254.42219044661, 8349.29031032357, 8579.356548258906, 8583.828323433496, 8427.789305267417, 8489.235968762718, 8505.362097842686, 8512.148785121439, 8529.957350213333, 6718.697658605374, 6809.93190068093, 6817.659117044128, 6818.795436136924, 6832.555883867532, 4816.397950256218, 4881.857652272173, 4917.9016419672125, 4959.504049595156, 5060.974695126501, 7775.961120194589, 7884.566348850868, 7936.127026027017, 7951.3638908886, 7999.080105787909, 7955.721549745731, 7976.242256985577, 8016.9198308016175, 8046.678132874619, 8153.22544358285, 6076.118962750465, 6124.142620033288, 6200.038993955944, 6223.190985171898, 6268.091126786681, 6726.8990965136545, 6727.529072964846, 6756.324367563205, 6765.695543700447, 6897.517173797786, 6175.6699383132645, 6243.500519958483, 6250.3749625037135, 6304.243490781136, 6395.328490508616, 6199.008158694587, 6275.215598050244, 6276.0, 6322.430981211713, 6339.651319177305, 5296.099663057213, 5428.782848686008, 5483.890322193454, 5759.65442073477, 5879.323877754113, 3981.124152686404, 4052.2908491013363, 4079.224947260011, 4095.201435720006, 4108.897277568085, 4081.7959102044183, 4135.441715368507, 4164.8334066637, 4201.810918508736, 4215.768132752605], "value": 3830.3001895003645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6370810648818, 349.9545059142311, 352.87296573233647, 354.2136457065315, 357.4316836230393, 5015.172496538067, 5023.2465130230485, 5047.823326183584, 5071.1886098224295, 5074.949250507494, 4967.528084831944, 4980.651354405184, 4983.7508124593805, 4990.550850423461, 5003.646827260289, 3766.3597188477956, 3804.524434445694, 3868.535775706905, 3902.9604359487935, 3950.044727859699, 3895.5714871364125, 3941.4876066111365, 3944.3689009758446, 3944.9013774655577, 3946.565877753445, 3915.9021024474473, 3956.287868183726, 3959.98020009901, 3963.2271707017144, 3973.3245348290716, 3623.0, 3826.885193444201, 3967.4842270504937, 3982.1174355003927, 3994.3209654358684, 3332.4001679697644, 3345.448001079819, 3351.312980838922, 3359.227377703142, 3373.510840928076, 4809.182438985381, 4810.6873053251775, 4814.181589129857, 4843.733594652293, 4864.0, 4302.397664326997, 4355.346697995326, 4362.149380870732, 4367.497737760166, 4377.627901628365, 4966.55301022906, 5186.0, 5199.558037566811, 5202.479752024805, 5208.661437006583, 3659.2864391443677, 3662.816859157058, 3662.816859157058, 3670.229251857113, 3686.594474607791, 5450.700211488366, 5469.617126801126, 5483.725813709339, 5485.369182543979, 5515.420880807497, 3628.745987780883, 3661.2677464507206, 3707.295613833363, 3714.517112775322, 3737.4767532545466, 3748.156664750409, 3766.5856755756845, 3774.2828862516585, 3776.9433458498142, 3785.73499855013, 4306.66493387051, 4310.418093557392, 4328.5455027222315, 4346.695731298842, 4348.7390756554705, 5086.237064440364, 5183.377994640668, 5207.713575753294, 5222.791088356499, 5236.764345604457, 1250.737345157509, 1262.5770366927181, 1269.720661454497, 1271.5676669932268, 1273.3251376770327, 819.332244220958, 848.2832006954114, 853.0, 861.401326078382, 862.7066797288826, 4438.759705415, 4566.520515345907, 4574.353232836176, 4592.10453961481, 4604.470485894098, 5407.459254074561, 5413.512783849473, 5420.105682562333, 5432.864178395493, 5446.455354464601, 4493.977530112394, 4577.267637178035, 4585.358049873021, 4588.334691469719, 4603.767172921131, 2791.595218693278, 2796.314902848774, 2808.6208361871295, 2816.6197563329097, 2827.1482179172676, 4922.252600326832, 4924.749665220937, 4947.060058588929, 4970.975145124251, 4999.650094474544, 5078.648092259091, 5367.007103685831, 5398.352197736297, 5436.755346009439, 5443.318745878541, 4877.5366340197625, 4887.900222449849, 4933.407991041026, 4957.958828646025, 4977.352944117241, 5190.429052804264, 5212.166053431432, 5222.503862133091, 5245.763940622604, 5302.469753024667, 4984.850454486371, 5172.482751724798, 5200.583953283804, 5201.982849947098, 5209.01028804526, 4927.655064145475, 4939.580135688507, 4941.135301322182, 4964.478729733326, 4966.925496117633, 3679.9448008280433, 3695.3186300233865, 3695.5934847167327, 3698.7410881238056, 3700.7964561948274, 4996.875078122931, 5202.531772140525, 5281.339832520935, 5356.196570514454, 5370.436104209002, 5048.974755126348, 5056.342675452168, 5061.924071138862, 5073.264376665289, 5089.6691715038405, 5050.868461553713, 5060.924086138784, 5132.486751324837, 5135.563477104488, 5149.639525233348, 4906.460289368238, 4923.778429970588, 5074.5940324774665, 5089.618278629192, 5095.184770436712, 4967.677100988424, 5030.773615187252, 5071.923921141112, 5098.668586541863, 5154.768035438339, 5049.2173713074535, 5094.2358646203365, 5106.897862042664, 5116.616253780907, 5119.513646203604], "value": 3895.1111443319696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.6021236727046, 644.9742010319587, 718.4214573834179, 779.392074182138, 786.8150984518637, 12537.498500059997, 13393.330333483324, 13443.462261509552, 13454.663633409169, 13564.660883477905, 13936.930315348434, 14054.156750594972, 14304.284785760696, 15153.318100685468, 15211.847881521182, 792.7027364738224, 809.134226377776, 809.5466538738295, 810.8986376702912, 812.760235730461, 771.965261563231, 799.1568894815966, 801.3829351399419, 815.1848151848152, 817.4237162800241, 842.0568962761715, 842.7429633961639, 843.6035063520167, 843.7763992541982, 845.0662018469595, 825.3232349473465, 830.3772170871846, 830.5390508267909, 839.7942504086477, 842.9114942930996, 614.0512907557834, 614.5575185866169, 614.7325913227716, 615.2616859768251, 616.2881871438495, 13961.162330260115, 14112.364943577564, 14265.215413152273, 14281.428742850274, 14299.714005719932, 11954.342511161884, 12181.878181218251, 12217.450214740358, 12333.753324933541, 13394.598162055154, 10640.414777187252, 10668.093212076983, 10735.926407359202, 10829.566817327297, 10912.781744365067, 3180.2844360019044, 3190.8245046522434, 3208.566843476124, 3216.549683044352, 3248.740100791931, 51741.2238816418, 52274.21588676135, 59809.70095149496, 60736.39263607351, 60937.6953115236, 10311.587536498606, 10334.844977325347, 10388.272820902464, 10463.895361046445, 10567.365958042543, 18871.150798214112, 18884.43346699601, 18889.244430222912, 18967.0, 18999.0, 6986.755463558751, 7112.893306600405, 7128.0, 7150.785476435715, 7319.341259286583, 3794.165283637595, 3844.442555829389, 3876.5154355705536, 3902.083010492532, 3954.4859168308512, 2951.631046119235, 3333.0834020644515, 3498.352804731133, 3524.54180956474, 3538.4692296155267, 561.0826299001162, 561.9772014932864, 566.6911533214408, 567.7899177304341, 587.9265091863517, 624.487919905673, 647.0843756085087, 650.8340373204898, 658.2857599504591, 667.519386042049, 9119.361644684808, 9148.359614827032, 9245.861312080324, 9374.437533747861, 9563.139317461322, 578.5082679722202, 583.1398686936734, 596.5376832954408, 600.1537831657342, 609.9359567245375, 4198.580141985838, 4233.5554766749665, 4343.087951530151, 4438.356438316426, 4463.4420697412825, 49387.50612493901, 57649.71175144098, 60946.695266523384, 65339.0, 65590.34409655938, 55994.0, 56054.71972640192, 56990.715046424506, 56992.43007569954, 58912.410875891546, 51491.48508514942, 51836.74081629568, 52046.47953520492, 52532.737336313076, 52777.2083418749, 7949.7217597383815, 8318.0, 8352.582370881553, 8385.32917366597, 8514.78713032179, 35274.823625881705, 35578.0, 35924.20378981093, 37544.81227593844, 37777.62222377741, 43995.56004439915, 44019.0, 44139.55860441354, 44545.55454445414, 46029.539704602525, 9989.60041598328, 10195.235357348376, 10281.434521101412, 10290.434026128336, 10330.070293673305, 11526.88473115258, 11593.130515211562, 11914.10644201671, 12600.87399125997, 12622.621321360373, 10650.520726567169, 10877.782444351227, 10886.129109671048, 11404.600838970928, 11455.484503197542, 10954.507047183055, 11300.152488563226, 11600.709982250173, 11626.244294120856, 11663.125265605284, 10446.373217606968, 10774.191935605018, 10890.727731806768, 11247.381394023407, 11279.830802537805, 9572.234221262142, 9653.613855445985, 9847.507624618884, 10003.649872254437, 10155.949220253851, 8546.658133674831, 9062.184403403726, 9109.22571581423, 9119.270458363182, 9195.356325057182], "value": 6349.134546471876, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 117.0, 114.0, 116.0, 115.0, 116.0, 117.0, 115.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 134.0, 184.0, 126.0, 127.0, 127.0, 125.0, 140.0, 125.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 172.0, 164.0, 166.0, 165.0, 164.0, 163.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 108.0, 78.0, 76.0, 77.0, 76.0, 91.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 89.0, 88.0, 89.0, 99.0, 86.0, 87.0, 102.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 151.0, 151.0, 151.0, 151.0, 151.0, 153.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 66.0, 66.0, 70.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 70.0, 70.0, 68.0, 68.0, 67.0, 68.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 89.0, 86.0, 85.0, 87.0, 91.0, 91.0, 86.0, 87.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 138.0, 146.0, 151.0, 137.0, 140.0, 138.0, 155.0, 197.0, 135.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 190.0, 183.0, 185.0, 186.0, 185.0, 179.0, 182.0, 180.0, 181.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 69.0, 72.0, 71.0, 71.0, 69.0, 74.0, 70.0, 70.0], "value": 70.8, "unit": "score"}]}]} 02:15:19 INFO - Return code: 0 02:15:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:15:19 ERROR - # TBPL SUCCESS # 02:15:19 INFO - Running post-action listener: _resource_record_post_action 02:15:19 INFO - [mozharness: 2017-01-10 10:15:19.575092Z] Finished run-tests step (success) 02:15:19 INFO - Running post-run listener: _resource_record_post_run 02:15:19 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 4096; Write bytes: 382148608; Read time: 16; Write time: 277940 02:15:19 INFO - TinderboxPrint: CPU usage
13.5% 02:15:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:15:19 INFO - TinderboxPrint: I/O write bytes / time
382,148,608 / 277,940 02:15:19 INFO - TinderboxPrint: CPU idle
8,285.2 (86.5%) 02:15:19 INFO - TinderboxPrint: CPU user
1,236.2 (12.9%) 02:15:19 INFO - TinderboxPrint: Swap in / out
0 / 0 02:15:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100073472; Read time: 0; Write time: 99804 02:15:19 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 282075136; Read time: 0; Write time: 178136 02:15:20 INFO - Running post-run listener: _upload_blobber_files 02:15:20 INFO - Blob upload gear active. 02:15:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:15:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:15:20 INFO - (blobuploader) - INFO - Open directory for files ... 02:15:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:15:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:27 INFO - (blobuploader) - INFO - Done attempting. 02:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:15:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:28 INFO - (blobuploader) - INFO - Done attempting. 02:15:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:15:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:15:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:29 INFO - (blobuploader) - INFO - Done attempting. 02:15:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:15:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:15:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:30 INFO - (blobuploader) - INFO - Done attempting. 02:15:30 INFO - (blobuploader) - INFO - Iteration through files over. 02:15:30 INFO - Return code: 0 02:15:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:15:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:15:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/74be78bf384e934c7081341530cefc3883f2770c7a52874af9a6c2ab1bfe969dbf9993821f4f7abc9ae901ad3a129724389dc8a2d3cc7ed07132cbf23dfd818d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cd2647d515303a5b8b36f971ec11085dfaab3ea626ae3fb5422abd19fe3d1268c5cc7b74e2f6711596ff868a5d8f5f4efe017dc6ab101788e436dc6218bd988", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a97b5813b005d180d652fb1a857f32fec1d0f20b2631bcc2290399c997460e6176d0fcbdadb37ab40270d084584067c663a8553e2afa43e3e35d943cdab04c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d1d5c2d427958cfe4aefcd7622d188e2b363cc5f4c7e0ce86f5d2a4c7772a941ee16a2b5184a5f6e0f236a270b50e12aabf9267aac4985628fc1a253e4187c8"} 02:15:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:15:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:15:30 INFO - Contents: 02:15:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/74be78bf384e934c7081341530cefc3883f2770c7a52874af9a6c2ab1bfe969dbf9993821f4f7abc9ae901ad3a129724389dc8a2d3cc7ed07132cbf23dfd818d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cd2647d515303a5b8b36f971ec11085dfaab3ea626ae3fb5422abd19fe3d1268c5cc7b74e2f6711596ff868a5d8f5f4efe017dc6ab101788e436dc6218bd988", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a97b5813b005d180d652fb1a857f32fec1d0f20b2631bcc2290399c997460e6176d0fcbdadb37ab40270d084584067c663a8553e2afa43e3e35d943cdab04c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d1d5c2d427958cfe4aefcd7622d188e2b363cc5f4c7e0ce86f5d2a4c7772a941ee16a2b5184a5f6e0f236a270b50e12aabf9267aac4985628fc1a253e4187c8"} 02:15:30 INFO - Running post-run listener: copy_logs_to_upload_dir 02:15:30 INFO - Copying logs to upload dir... 02:15:30 INFO - mkdir: /builds/slave/test/build/upload/logs 02:15:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.228255 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-01-10 02:15:29.542174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:29.546528) ========= 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=eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/74be78bf384e934c7081341530cefc3883f2770c7a52874af9a6c2ab1bfe969dbf9993821f4f7abc9ae901ad3a129724389dc8a2d3cc7ed07132cbf23dfd818d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cd2647d515303a5b8b36f971ec11085dfaab3ea626ae3fb5422abd19fe3d1268c5cc7b74e2f6711596ff868a5d8f5f4efe017dc6ab101788e436dc6218bd988", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a97b5813b005d180d652fb1a857f32fec1d0f20b2631bcc2290399c997460e6176d0fcbdadb37ab40270d084584067c663a8553e2afa43e3e35d943cdab04c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d1d5c2d427958cfe4aefcd7622d188e2b363cc5f4c7e0ce86f5d2a4c7772a941ee16a2b5184a5f6e0f236a270b50e12aabf9267aac4985628fc1a253e4187c8"} build_url:https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011730 build_url: 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/74be78bf384e934c7081341530cefc3883f2770c7a52874af9a6c2ab1bfe969dbf9993821f4f7abc9ae901ad3a129724389dc8a2d3cc7ed07132cbf23dfd818d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cd2647d515303a5b8b36f971ec11085dfaab3ea626ae3fb5422abd19fe3d1268c5cc7b74e2f6711596ff868a5d8f5f4efe017dc6ab101788e436dc6218bd988", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a97b5813b005d180d652fb1a857f32fec1d0f20b2631bcc2290399c997460e6176d0fcbdadb37ab40270d084584067c663a8553e2afa43e3e35d943cdab04c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5d1d5c2d427958cfe4aefcd7622d188e2b363cc5f4c7e0ce86f5d2a4c7772a941ee16a2b5184a5f6e0f236a270b50e12aabf9267aac4985628fc1a253e4187c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:29.574846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:29.575271) ========= 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=eca2ab57546de7b41f256b19000001ef-1484040639.49575-768797223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:29.657795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 02:15:29.658136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 02:15:29.658440) ========= ========= Total master_lag: 0.18 =========