builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1483745285.14 results: success (0) revision: e7b1d82db69bc147df429a220420e412ff3dbe98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.140875) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.141273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.141567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.155934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.156203) ========= 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=ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-06 15:28:05-- 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% 31.2M=0s 2017-01-06 15:28:05 (31.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.318070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.318376) ========= 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=ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021948 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.368411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:05.368751) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev e7b1d82db69bc147df429a220420e412ff3dbe98 --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 e7b1d82db69bc147df429a220420e412ff3dbe98 --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=ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-06 15:28:05,986 truncating revision to first 12 chars 2017-01-06 15:28:05,986 Setting DEBUG logging. 2017-01-06 15:28:05,986 attempt 1/10 2017-01-06 15:28:05,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/e7b1d82db69b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 15:28:06,418 unpacking tar archive at: graphics-e7b1d82db69b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.763001 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:06.144454) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:06.144784) ========= script_repo_revision: e7b1d82db69bc147df429a220420e412ff3dbe98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:06.145143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:06.145428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 15:28:06.155779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-06 15:28:06.156084) ========= /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=ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:06 INFO - MultiFileLogger online at 20170106 15:28:06 in /builds/slave/test 15:28:06 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 15:28:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:06 INFO - {'append_to_log': False, 15:28:06 INFO - 'base_work_dir': '/builds/slave/test', 15:28:06 INFO - 'blob_upload_branch': 'Graphics', 15:28:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:06 INFO - 'branch': 'Graphics', 15:28:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:06 INFO - 'config_files': ('talos/linux_config.py',), 15:28:06 INFO - 'default_actions': ('clobber', 15:28:06 INFO - 'read-buildbot-config', 15:28:06 INFO - 'download-and-extract', 15:28:06 INFO - 'populate-webroot', 15:28:06 INFO - 'create-virtualenv', 15:28:06 INFO - 'install', 15:28:06 INFO - 'run-tests'), 15:28:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:06 INFO - 'download_minidump_stackwalk': True, 15:28:06 INFO - 'download_symbols': 'ondemand', 15:28:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:06 INFO - 'installer_path': 'installer.exe', 15:28:06 INFO - 'log_level': 'info', 15:28:06 INFO - 'log_name': 'talos', 15:28:06 INFO - 'log_to_console': True, 15:28:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:06 INFO - 'opt_config_files': (), 15:28:06 INFO - 'pip_index': False, 15:28:06 INFO - 'sps_profile': False, 15:28:06 INFO - 'sps_profile_interval': 0, 15:28:06 INFO - 'suite': 'dromaeojs-e10s', 15:28:06 INFO - 'system_bits': '32', 15:28:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:06 INFO - 'title': 'talos-linux64-ix-035', 15:28:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:06 INFO - 'use_talos_json': True, 15:28:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:06 INFO - 'work_dir': 'build'} 15:28:06 INFO - [mozharness: 2017-01-06 23:28:06.868379Z] Running clobber step. 15:28:06 INFO - Running pre-action listener: _resource_record_pre_action 15:28:06 INFO - Running main action method: clobber 15:28:06 INFO - rmtree: /builds/slave/test/build 15:28:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:07 INFO - Running post-action listener: _resource_record_post_action 15:28:07 INFO - [mozharness: 2017-01-06 23:28:07.331626Z] Finished clobber step (success) 15:28:07 INFO - [mozharness: 2017-01-06 23:28:07.331726Z] Running read-buildbot-config step. 15:28:07 INFO - Running pre-action listener: _resource_record_pre_action 15:28:07 INFO - Running main action method: read_buildbot_config 15:28:07 INFO - Using buildbot properties: 15:28:07 INFO - { 15:28:07 INFO - "project": "", 15:28:07 INFO - "product": "firefox", 15:28:07 INFO - "who": "kgupta@mozilla.com", 15:28:07 INFO - "installer_path": "public/build/target.tar.bz2", 15:28:07 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 15:28:07 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 15:28:07 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 15:28:07 INFO - "stage_platform": "linux64", 15:28:07 INFO - "basedir": "/builds/slave/test", 15:28:07 INFO - "buildnumber": 48, 15:28:07 INFO - "platform": "ubuntu64_hw", 15:28:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:28:07 INFO - "slavebuilddir": "test", 15:28:07 INFO - "taskId": "XFC3xtANTr6i43ZTMvIp3Q", 15:28:07 INFO - "branch": "graphics", 15:28:07 INFO - "script_repo_revision": "default", 15:28:07 INFO - "revision": "e7b1d82db69bc147df429a220420e412ff3dbe98", 15:28:07 INFO - "slavename": "talos-linux64-ix-035", 15:28:07 INFO - "repo_path": "projects/graphics" 15:28:07 INFO - } 15:28:07 INFO - Finding installer, test and symbols from parent task. 15:28:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XFC3xtANTr6i43ZTMvIp3Q'}, attempt #1 15:28:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XFC3xtANTr6i43ZTMvIp3Q'}, attempt #1 15:28:08 INFO - Task dependencies: KQ_C3sZoRS20IMXedouOyA 15:28:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA'}, attempt #1 15:28:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2 15:28:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/test_packages.json 15:28:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.crashreporter-symbols.zip 15:28:08 INFO - Running post-action listener: _resource_record_post_action 15:28:08 INFO - [mozharness: 2017-01-06 23:28:08.841506Z] Finished read-buildbot-config step (success) 15:28:08 INFO - [mozharness: 2017-01-06 23:28:08.841724Z] Running download-and-extract step. 15:28:08 INFO - Running pre-action listener: _resource_record_pre_action 15:28:08 INFO - Running main action method: download_and_extract 15:28:08 INFO - mkdir: /builds/slave/test/build/tests 15:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:08 INFO - trying https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.test_packages.json 15:28:08 INFO - Downloading https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:28:09 INFO - Downloaded 896 bytes. 15:28:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:28:09 INFO - Using the following test package requirements: 15:28:09 INFO - {u'common': [u'target.common.tests.zip'], 15:28:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:28:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:28:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:28:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:28:09 INFO - u'mozbase': [u'target.common.tests.zip'], 15:28:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:28:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:28:09 INFO - u'web-platform': [u'target.common.tests.zip', 15:28:09 INFO - u'target.web-platform.tests.zip'], 15:28:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:28:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:28:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.common.tests.zip 15:28:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:28:09 INFO - Fetch https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.common.tests.zip into memory 15:28:10 INFO - Expected file size: 20244966 15:28:10 INFO - Obtained file size: 20244966 15:28:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:28:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.common.tests.zip 15:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.common.tests.zip into memory 15:28:15 INFO - Expected file size: 20244966 15:28:15 INFO - Obtained file size: 20244966 15:28:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.talos.tests.zip 15:28:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:28:19 INFO - Fetch https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.talos.tests.zip into memory 15:28:20 INFO - Expected file size: 14403730 15:28:20 INFO - Obtained file size: 14403730 15:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:20 INFO - trying https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2 15:28:20 INFO - Downloading https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:28:21 INFO - Downloaded 55892652 bytes. 15:28:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2 15:28:21 INFO - mkdir: /builds/slave/test/properties 15:28:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:28:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:28:21 INFO - Contents: 15:28:21 INFO - build_url:https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2 15:28:21 INFO - Running post-action listener: _resource_record_post_action 15:28:21 INFO - Running post-action listener: set_extra_try_arguments 15:28:21 INFO - [mozharness: 2017-01-06 23:28:21.720504Z] Finished download-and-extract step (success) 15:28:21 INFO - [mozharness: 2017-01-06 23:28:21.720620Z] Running populate-webroot step. 15:28:21 INFO - Running pre-action listener: _resource_record_pre_action 15:28:21 INFO - Running main action method: populate_webroot 15:28:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:21 INFO - '--tppagecycles', 15:28:21 INFO - '7'], 15:28:21 INFO - 'tests': ['tsvgm']}}, 15:28:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:28:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:28:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:28:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:28:21 INFO - 'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:28:21 INFO - 'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['damp', 'tps']}, 15:28:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:28:21 INFO - 'tests': ['damp', 'tps']}, 15:28:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['dromaeo_dom']}, 15:28:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['basic_compositor_video']}, 15:28:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:28:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['a11yr', 15:28:21 INFO - 'ts_paint', 15:28:21 INFO - 'tpaint', 15:28:21 INFO - 'sessionrestore', 15:28:21 INFO - 'sessionrestore_no_auto_restore', 15:28:21 INFO - 'tabpaint']}, 15:28:21 INFO - 'other-e10s': {'tests': ['a11yr', 15:28:21 INFO - 'ts_paint', 15:28:21 INFO - 'tpaint', 15:28:21 INFO - 'sessionrestore', 15:28:21 INFO - 'sessionrestore_no_auto_restore', 15:28:21 INFO - 'tabpaint']}, 15:28:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:28:21 INFO - 'ts_paint', 15:28:21 INFO - 'tpaint', 15:28:21 INFO - 'sessionrestore', 15:28:21 INFO - 'sessionrestore_no_auto_restore', 15:28:21 INFO - 'tabpaint']}, 15:28:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:28:21 INFO - 'ts_paint', 15:28:21 INFO - 'tpaint', 15:28:21 INFO - 'sessionrestore', 15:28:21 INFO - 'sessionrestore_no_auto_restore', 15:28:21 INFO - 'tabpaint']}, 15:28:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['a11yr', 15:28:21 INFO - 'ts_paint', 15:28:21 INFO - 'tpaint', 15:28:21 INFO - 'sessionrestore', 15:28:21 INFO - 'sessionrestore_no_auto_restore', 15:28:21 INFO - 'tabpaint']}, 15:28:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['a11yr', 15:28:21 INFO - 'ts_paint', 15:28:21 INFO - 'tpaint', 15:28:21 INFO - 'sessionrestore', 15:28:21 INFO - 'sessionrestore_no_auto_restore', 15:28:21 INFO - 'tabpaint']}, 15:28:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['tsvgx', 15:28:21 INFO - 'tsvgr_opacity', 15:28:21 INFO - 'tart', 15:28:21 INFO - 'tscrollx', 15:28:21 INFO - 'cart', 15:28:21 INFO - 'tsvg_static']}, 15:28:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:28:21 INFO - 'tsvgr_opacity', 15:28:21 INFO - 'tart', 15:28:21 INFO - 'tscrollx', 15:28:21 INFO - 'cart', 15:28:21 INFO - 'tsvg_static']}, 15:28:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:28:21 INFO - 'talos_options': ['--disable-e10s'], 15:28:21 INFO - 'tests': ['tp5o']}, 15:28:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:28:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:28:21 INFO - 'talos_options': ['--disable-e10s', 15:28:21 INFO - '--xperf_path', 15:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:21 INFO - 'tests': ['tp5n']}, 15:28:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:28:21 INFO - 'talos_options': ['--xperf_path', 15:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:21 INFO - 'tests': ['tp5n']}}, 15:28:21 INFO - 'talos.zip': {'path': '', 15:28:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:21 INFO - Running post-action listener: _resource_record_post_action 15:28:21 INFO - [mozharness: 2017-01-06 23:28:21.733780Z] Finished populate-webroot step (success) 15:28:21 INFO - [mozharness: 2017-01-06 23:28:21.733873Z] Running create-virtualenv step. 15:28:21 INFO - Running pre-action listener: _resource_record_pre_action 15:28:21 INFO - Running main action method: create_virtualenv 15:28:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:28:21 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 15:28:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:28:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:21 INFO - Using real prefix '/usr' 15:28:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:28:22 INFO - Installing distribute.............................................................................................................................................................................................done. 15:28:24 INFO - Installing pip.................done. 15:28:24 INFO - Return code: 0 15:28:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:28:24 INFO - Reading from file tmpfile_stdout 15:28:24 INFO - Output received: 15:28:24 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) 15:28:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:28:24 INFO - Using env: {'DISPLAY': ':0', 15:28:24 INFO - 'HOME': '/home/cltbld', 15:28:24 INFO - 'LANG': 'en_US.UTF-8', 15:28:24 INFO - 'LANGUAGE': 'en_US:en', 15:28:24 INFO - 'LOGNAME': 'cltbld', 15:28:24 INFO - 'MAIL': '/var/mail/cltbld', 15:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:24 INFO - 'MOZ_NO_REMOTE': '1', 15:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:24 INFO - 'NO_EM_RESTART': '1', 15:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:24 INFO - 'PWD': '/builds/slave/test', 15:28:24 INFO - 'SHELL': '/bin/bash', 15:28:24 INFO - 'SHLVL': '1', 15:28:24 INFO - 'TERM': 'linux', 15:28:24 INFO - 'TMOUT': '86400', 15:28:24 INFO - 'USER': 'cltbld', 15:28:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:24 INFO - '_': '/tools/buildbot/bin/python'} 15:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:24 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 15:28:24 INFO - Cleaning up... 15:28:24 INFO - Return code: 0 15:28:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:28:24 INFO - Using env: {'DISPLAY': ':0', 15:28:24 INFO - 'HOME': '/home/cltbld', 15:28:24 INFO - 'LANG': 'en_US.UTF-8', 15:28:24 INFO - 'LANGUAGE': 'en_US:en', 15:28:24 INFO - 'LOGNAME': 'cltbld', 15:28:24 INFO - 'MAIL': '/var/mail/cltbld', 15:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:24 INFO - 'MOZ_NO_REMOTE': '1', 15:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:24 INFO - 'NO_EM_RESTART': '1', 15:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:24 INFO - 'PWD': '/builds/slave/test', 15:28:24 INFO - 'SHELL': '/bin/bash', 15:28:24 INFO - 'SHLVL': '1', 15:28:24 INFO - 'TERM': 'linux', 15:28:24 INFO - 'TMOUT': '86400', 15:28:24 INFO - 'USER': 'cltbld', 15:28:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:24 INFO - '_': '/tools/buildbot/bin/python'} 15:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:24 INFO - Downloading/unpacking psutil>=3.1.1 15:28:24 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 15:28:24 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 15:28:24 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 15:28:24 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 15:28:24 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 15:28:24 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 15:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:27 INFO - Installing collected packages: psutil 15:28:27 INFO - Running setup.py install for psutil 15:28:27 INFO - building 'psutil._psutil_linux' extension 15:28:27 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 15:28:27 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 15:28:27 INFO - building 'psutil._psutil_posix' extension 15:28:27 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 15:28:27 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 15:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:27 INFO - Successfully installed psutil 15:28:27 INFO - Cleaning up... 15:28:27 INFO - Return code: 0 15:28:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:28:27 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')]} 15:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:27 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')]} 15:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:27 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:27 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 15:28:27 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 15:28:27 INFO - Using env: {'DISPLAY': ':0', 15:28:27 INFO - 'HOME': '/home/cltbld', 15:28:27 INFO - 'LANG': 'en_US.UTF-8', 15:28:27 INFO - 'LANGUAGE': 'en_US:en', 15:28:27 INFO - 'LOGNAME': 'cltbld', 15:28:27 INFO - 'MAIL': '/var/mail/cltbld', 15:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:27 INFO - 'MOZ_NO_REMOTE': '1', 15:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:27 INFO - 'NO_EM_RESTART': '1', 15:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:27 INFO - 'PWD': '/builds/slave/test', 15:28:27 INFO - 'SHELL': '/bin/bash', 15:28:27 INFO - 'SHLVL': '1', 15:28:27 INFO - 'TERM': 'linux', 15:28:27 INFO - 'TMOUT': '86400', 15:28:27 INFO - 'USER': 'cltbld', 15:28:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:27 INFO - '_': '/tools/buildbot/bin/python'} 15:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:28:27 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 15:28:27 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 15:28:27 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 15:28:27 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 15:28:27 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 15:28:27 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 15:28:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:28:29 INFO - Installing collected packages: mozsystemmonitor 15:28:29 INFO - Running setup.py install for mozsystemmonitor 15:28:30 INFO - Successfully installed mozsystemmonitor 15:28:30 INFO - Cleaning up... 15:28:30 INFO - Return code: 0 15:28:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:28:30 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')]} 15:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:30 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')]} 15:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:30 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:30 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 15:28:30 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 15:28:30 INFO - Using env: {'DISPLAY': ':0', 15:28:30 INFO - 'HOME': '/home/cltbld', 15:28:30 INFO - 'LANG': 'en_US.UTF-8', 15:28:30 INFO - 'LANGUAGE': 'en_US:en', 15:28:30 INFO - 'LOGNAME': 'cltbld', 15:28:30 INFO - 'MAIL': '/var/mail/cltbld', 15:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:30 INFO - 'MOZ_NO_REMOTE': '1', 15:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:30 INFO - 'NO_EM_RESTART': '1', 15:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:30 INFO - 'PWD': '/builds/slave/test', 15:28:30 INFO - 'SHELL': '/bin/bash', 15:28:30 INFO - 'SHLVL': '1', 15:28:30 INFO - 'TERM': 'linux', 15:28:30 INFO - 'TMOUT': '86400', 15:28:30 INFO - 'USER': 'cltbld', 15:28:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:30 INFO - '_': '/tools/buildbot/bin/python'} 15:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:30 INFO - Downloading/unpacking jsonschema==2.5.1 15:28:30 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 15:28:30 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 15:28:30 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 15:28:30 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 15:28:30 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 15:28:30 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 15:28:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:28:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:28:32 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 15:28:32 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 15:28:32 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 15:28:32 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 15:28:32 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 15:28:32 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 15:28:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:28:32 INFO - warning: no files found matching '*.txt' 15:28:32 INFO - no previously-included directories found matching 'build' 15:28:32 INFO - no previously-included directories found matching 'dist' 15:28:32 INFO - no previously-included directories found matching '.git*' 15:28:32 INFO - Installing collected packages: jsonschema, functools32 15:28:32 INFO - Running setup.py install for functools32 15:28:32 INFO - warning: no files found matching '*.txt' 15:28:32 INFO - no previously-included directories found matching 'build' 15:28:32 INFO - no previously-included directories found matching 'dist' 15:28:32 INFO - no previously-included directories found matching '.git*' 15:28:32 INFO - Successfully installed jsonschema functools32 15:28:32 INFO - Cleaning up... 15:28:32 INFO - Return code: 0 15:28:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:32 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:32 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 15:28:32 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 15:28:32 INFO - Using env: {'DISPLAY': ':0', 15:28:32 INFO - 'HOME': '/home/cltbld', 15:28:32 INFO - 'LANG': 'en_US.UTF-8', 15:28:32 INFO - 'LANGUAGE': 'en_US:en', 15:28:32 INFO - 'LOGNAME': 'cltbld', 15:28:32 INFO - 'MAIL': '/var/mail/cltbld', 15:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:32 INFO - 'MOZ_NO_REMOTE': '1', 15:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:32 INFO - 'NO_EM_RESTART': '1', 15:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:32 INFO - 'PWD': '/builds/slave/test', 15:28:32 INFO - 'SHELL': '/bin/bash', 15:28:32 INFO - 'SHLVL': '1', 15:28:32 INFO - 'TERM': 'linux', 15:28:32 INFO - 'TMOUT': '86400', 15:28:32 INFO - 'USER': 'cltbld', 15:28:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:32 INFO - '_': '/tools/buildbot/bin/python'} 15:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:28:32 INFO - Cleaning up... 15:28:33 INFO - Return code: 0 15:28:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:33 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 15:28:33 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 15:28:33 INFO - Using env: {'DISPLAY': ':0', 15:28:33 INFO - 'HOME': '/home/cltbld', 15:28:33 INFO - 'LANG': 'en_US.UTF-8', 15:28:33 INFO - 'LANGUAGE': 'en_US:en', 15:28:33 INFO - 'LOGNAME': 'cltbld', 15:28:33 INFO - 'MAIL': '/var/mail/cltbld', 15:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:33 INFO - 'MOZ_NO_REMOTE': '1', 15:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:33 INFO - 'NO_EM_RESTART': '1', 15:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:33 INFO - 'PWD': '/builds/slave/test', 15:28:33 INFO - 'SHELL': '/bin/bash', 15:28:33 INFO - 'SHLVL': '1', 15:28:33 INFO - 'TERM': 'linux', 15:28:33 INFO - 'TMOUT': '86400', 15:28:33 INFO - 'USER': 'cltbld', 15:28:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:33 INFO - '_': '/tools/buildbot/bin/python'} 15:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:33 INFO - Downloading/unpacking blobuploader==1.2.4 15:28:33 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 15:28:33 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 15:28:33 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 15:28:33 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 15:28:33 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 15:28:33 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 15:28:35 INFO - Downloading blobuploader-1.2.4.tar.gz 15:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:28:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:28:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 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 15:28:35 INFO - Downloading docopt-0.6.1.tar.gz 15:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:28:36 INFO - Installing collected packages: blobuploader, requests, docopt 15:28:36 INFO - Running setup.py install for blobuploader 15:28:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:28:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:28:36 INFO - Running setup.py install for requests 15:28:36 INFO - Running setup.py install for docopt 15:28:36 INFO - Successfully installed blobuploader requests docopt 15:28:36 INFO - Cleaning up... 15:28:36 INFO - Return code: 0 15:28:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:36 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')]} 15:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:36 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')]} 15:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:36 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:36 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 15:28:36 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 15:28:36 INFO - Using env: {'DISPLAY': ':0', 15:28:36 INFO - 'HOME': '/home/cltbld', 15:28:36 INFO - 'LANG': 'en_US.UTF-8', 15:28:36 INFO - 'LANGUAGE': 'en_US:en', 15:28:36 INFO - 'LOGNAME': 'cltbld', 15:28:36 INFO - 'MAIL': '/var/mail/cltbld', 15:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:36 INFO - 'MOZ_NO_REMOTE': '1', 15:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:36 INFO - 'NO_EM_RESTART': '1', 15:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:36 INFO - 'PWD': '/builds/slave/test', 15:28:36 INFO - 'SHELL': '/bin/bash', 15:28:36 INFO - 'SHLVL': '1', 15:28:36 INFO - 'TERM': 'linux', 15:28:36 INFO - 'TMOUT': '86400', 15:28:36 INFO - 'USER': 'cltbld', 15:28:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:36 INFO - '_': '/tools/buildbot/bin/python'} 15:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:36 INFO - Running setup.py (path:/tmp/pip-rC7TTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:36 INFO - Running setup.py (path:/tmp/pip-_jI_LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:37 INFO - Running setup.py (path:/tmp/pip-ymy99j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:37 INFO - Running setup.py (path:/tmp/pip-r9SEWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:37 INFO - Running setup.py (path:/tmp/pip-3nCgUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:37 INFO - Running setup.py (path:/tmp/pip-YmlzTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:37 INFO - Running setup.py (path:/tmp/pip-loi9Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:37 INFO - Running setup.py (path:/tmp/pip-VYMFd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:37 INFO - Running setup.py (path:/tmp/pip-JM2K0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:37 INFO - Running setup.py (path:/tmp/pip-sAX1mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:37 INFO - Running setup.py (path:/tmp/pip-8844rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:37 INFO - Running setup.py (path:/tmp/pip-16UG9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:37 INFO - Running setup.py (path:/tmp/pip-PllKOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:37 INFO - Running setup.py (path:/tmp/pip-Ts0Vnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:37 INFO - Running setup.py (path:/tmp/pip-Z7Dprv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:37 INFO - Running setup.py (path:/tmp/pip-jF4Dya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:38 INFO - Running setup.py (path:/tmp/pip-XJjKh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:28:38 INFO - Running setup.py install for manifestparser 15:28:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Running setup.py install for mozcrash 15:28:38 INFO - Running setup.py install for mozdebug 15:28:38 INFO - Running setup.py install for mozdevice 15:28:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Running setup.py install for mozfile 15:28:38 INFO - Running setup.py install for mozhttpd 15:28:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Running setup.py install for mozinfo 15:28:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Running setup.py install for mozInstall 15:28:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:28:38 INFO - Running setup.py install for mozleak 15:28:38 INFO - Running setup.py install for mozlog 15:28:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:28:39 INFO - Running setup.py install for moznetwork 15:28:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:28:39 INFO - Running setup.py install for mozprocess 15:28:39 INFO - Running setup.py install for mozprofile 15:28:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:28:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:28:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:28:39 INFO - Running setup.py install for mozrunner 15:28:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:28:39 INFO - Running setup.py install for mozscreenshot 15:28:39 INFO - Running setup.py install for moztest 15:28:39 INFO - Running setup.py install for mozversion 15:28:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:28:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:28:39 INFO - Cleaning up... 15:28:39 INFO - Return code: 0 15:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:39 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')]} 15:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:39 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')]} 15:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:39 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:39 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 15:28:39 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 15:28:39 INFO - Using env: {'DISPLAY': ':0', 15:28:39 INFO - 'HOME': '/home/cltbld', 15:28:39 INFO - 'LANG': 'en_US.UTF-8', 15:28:39 INFO - 'LANGUAGE': 'en_US:en', 15:28:39 INFO - 'LOGNAME': 'cltbld', 15:28:39 INFO - 'MAIL': '/var/mail/cltbld', 15:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:39 INFO - 'MOZ_NO_REMOTE': '1', 15:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:39 INFO - 'NO_EM_RESTART': '1', 15:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:39 INFO - 'PWD': '/builds/slave/test', 15:28:39 INFO - 'SHELL': '/bin/bash', 15:28:39 INFO - 'SHLVL': '1', 15:28:39 INFO - 'TERM': 'linux', 15:28:39 INFO - 'TMOUT': '86400', 15:28:39 INFO - 'USER': 'cltbld', 15:28:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:39 INFO - '_': '/tools/buildbot/bin/python'} 15:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:40 INFO - Running setup.py (path:/tmp/pip-uzMQaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:40 INFO - Running setup.py (path:/tmp/pip-kfkqBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:40 INFO - Running setup.py (path:/tmp/pip-t7OBJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:40 INFO - Running setup.py (path:/tmp/pip-_uKikA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:40 INFO - Running setup.py (path:/tmp/pip-DuBdIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:40 INFO - Running setup.py (path:/tmp/pip-vUXUlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:40 INFO - Running setup.py (path:/tmp/pip-QqFgvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:40 INFO - Running setup.py (path:/tmp/pip-17UhBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:40 INFO - Running setup.py (path:/tmp/pip-lQcUgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:40 INFO - Running setup.py (path:/tmp/pip-sNRyTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:40 INFO - Running setup.py (path:/tmp/pip-3xnxM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:40 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:40 INFO - Running setup.py (path:/tmp/pip-0fT8JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:41 INFO - Running setup.py (path:/tmp/pip-JTMT8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:41 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)) 15:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:41 INFO - Running setup.py (path:/tmp/pip-mCLfeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:41 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)) 15:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:41 INFO - Running setup.py (path:/tmp/pip-hkyRCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:41 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)) 15:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:41 INFO - Running setup.py (path:/tmp/pip-r6hBmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:41 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)) 15:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:41 INFO - Running setup.py (path:/tmp/pip-PHw3gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:41 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)) 15:28:41 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)) 15:28:41 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)) 15:28:41 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)) 15:28:41 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)) 15:28:41 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)) 15:28:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:28:41 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 15:28:41 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 15:28:41 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 15:28:41 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 15:28:41 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 15:28:41 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 15:28:43 INFO - Downloading blessings-1.6.tar.gz 15:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:28:43 INFO - Installing collected packages: blessings 15:28:43 INFO - Running setup.py install for blessings 15:28:43 INFO - Successfully installed blessings 15:28:43 INFO - Cleaning up... 15:28:43 INFO - Return code: 0 15:28:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:28:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:43 INFO - Reading from file tmpfile_stdout 15:28:43 INFO - Current package versions: 15:28:43 INFO - argparse == 1.2.1 15:28:43 INFO - blessings == 1.6 15:28:43 INFO - blobuploader == 1.2.4 15:28:43 INFO - docopt == 0.6.1 15:28:43 INFO - functools32 == 3.2.3-2 15:28:43 INFO - jsonschema == 2.5.1 15:28:43 INFO - manifestparser == 1.1 15:28:43 INFO - mozInstall == 1.12 15:28:43 INFO - mozcrash == 1.0 15:28:43 INFO - mozdebug == 0.1 15:28:43 INFO - mozdevice == 0.49 15:28:43 INFO - mozfile == 1.2 15:28:43 INFO - mozhttpd == 0.7 15:28:43 INFO - mozinfo == 0.9 15:28:43 INFO - mozleak == 0.1 15:28:43 INFO - mozlog == 3.4 15:28:43 INFO - moznetwork == 0.27 15:28:43 INFO - mozprocess == 0.23 15:28:43 INFO - mozprofile == 0.28 15:28:43 INFO - mozrunner == 6.13 15:28:43 INFO - mozscreenshot == 0.1 15:28:43 INFO - mozsystemmonitor == 0.3 15:28:43 INFO - moztest == 0.8 15:28:43 INFO - mozversion == 1.4 15:28:43 INFO - psutil == 3.1.1 15:28:43 INFO - requests == 1.2.3 15:28:43 INFO - wsgiref == 0.1.2 15:28:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:43 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')]} 15:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:43 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')]} 15:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:43 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:43 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 15:28:43 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 15:28:43 INFO - Using env: {'DISPLAY': ':0', 15:28:43 INFO - 'HOME': '/home/cltbld', 15:28:43 INFO - 'LANG': 'en_US.UTF-8', 15:28:43 INFO - 'LANGUAGE': 'en_US:en', 15:28:43 INFO - 'LOGNAME': 'cltbld', 15:28:43 INFO - 'MAIL': '/var/mail/cltbld', 15:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:43 INFO - 'MOZ_NO_REMOTE': '1', 15:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:43 INFO - 'NO_EM_RESTART': '1', 15:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:43 INFO - 'PWD': '/builds/slave/test', 15:28:43 INFO - 'SHELL': '/bin/bash', 15:28:43 INFO - 'SHLVL': '1', 15:28:43 INFO - 'TERM': 'linux', 15:28:43 INFO - 'TMOUT': '86400', 15:28:43 INFO - 'USER': 'cltbld', 15:28:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:43 INFO - '_': '/tools/buildbot/bin/python'} 15:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 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)) 15:28:44 INFO - Cleaning up... 15:28:44 INFO - Return code: 0 15:28:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:28:44 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')]} 15:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:44 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')]} 15:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:44 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 0x17bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', '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 15:28:44 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 15:28:44 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 15:28:44 INFO - Using env: {'DISPLAY': ':0', 15:28:44 INFO - 'HOME': '/home/cltbld', 15:28:44 INFO - 'LANG': 'en_US.UTF-8', 15:28:44 INFO - 'LANGUAGE': 'en_US:en', 15:28:44 INFO - 'LOGNAME': 'cltbld', 15:28:44 INFO - 'MAIL': '/var/mail/cltbld', 15:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:44 INFO - 'MOZ_NO_REMOTE': '1', 15:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:44 INFO - 'NO_EM_RESTART': '1', 15:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:44 INFO - 'PWD': '/builds/slave/test', 15:28:44 INFO - 'SHELL': '/bin/bash', 15:28:44 INFO - 'SHLVL': '1', 15:28:44 INFO - 'TERM': 'linux', 15:28:44 INFO - 'TMOUT': '86400', 15:28:44 INFO - 'USER': 'cltbld', 15:28:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:44 INFO - '_': '/tools/buildbot/bin/python'} 15:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:28:44 INFO - Cleaning up... 15:28:44 INFO - Return code: 0 15:28:44 INFO - Running post-action listener: _resource_record_post_action 15:28:44 INFO - Running post-action listener: _start_resource_monitoring 15:28:44 INFO - Starting resource monitoring. 15:28:44 INFO - [mozharness: 2017-01-06 23:28:44.311177Z] Finished create-virtualenv step (success) 15:28:44 INFO - [mozharness: 2017-01-06 23:28:44.311669Z] Running install step. 15:28:44 INFO - Running pre-action listener: _resource_record_pre_action 15:28:44 INFO - Running main action method: install 15:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:44 INFO - Reading from file tmpfile_stdout 15:28:44 INFO - Detecting whether we're running mozinstall >=1.0... 15:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:28:44 INFO - Reading from file tmpfile_stdout 15:28:44 INFO - Output received: 15:28:44 INFO - Usage: mozinstall [options] installer 15:28:44 INFO - Options: 15:28:44 INFO - -h, --help show this help message and exit 15:28:44 INFO - -d DEST, --destination=DEST 15:28:44 INFO - Directory to install application into. [default: 15:28:44 INFO - "/builds/slave/test"] 15:28:44 INFO - --app=APP Application being installed. [default: firefox] 15:28:44 INFO - mkdir: /builds/slave/test/build/application 15:28:44 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'] 15:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:29:00 INFO - Reading from file tmpfile_stdout 15:29:00 INFO - Output received: 15:29:00 INFO - /builds/slave/test/build/application/firefox/firefox 15:29:00 INFO - Running post-action listener: _resource_record_post_action 15:29:00 INFO - [mozharness: 2017-01-06 23:29:00.736075Z] Finished install step (success) 15:29:00 INFO - [mozharness: 2017-01-06 23:29:00.736333Z] Running run-tests step. 15:29:00 INFO - Running pre-action listener: _resource_record_pre_action 15:29:00 INFO - Running main action method: run_tests 15:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:29:00 INFO - Python 2.7.3 15:29:00 INFO - Return code: 0 15:29:00 INFO - grabbing minidump binary from tooltool 15:29: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')]} 15:29:00 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 0x1b2e3f0>, '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 0x1b2ecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:29:00 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 15:29:00 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 15:29:00 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 15:29:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:00 INFO - Return code: 0 15:29:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:29:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:29:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:29:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:29:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:29:00 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/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 15:29:00 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/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 15:29:00 INFO - Using env: {'DISPLAY': ':0', 15:29:00 INFO - 'HOME': '/home/cltbld', 15:29:00 INFO - 'LANG': 'en_US.UTF-8', 15:29:00 INFO - 'LANGUAGE': 'en_US:en', 15:29:00 INFO - 'LOGNAME': 'cltbld', 15:29:00 INFO - 'MAIL': '/var/mail/cltbld', 15:29:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:00 INFO - 'MOZ_NO_REMOTE': '1', 15:29:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:00 INFO - 'NO_EM_RESTART': '1', 15:29:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:00 INFO - 'PWD': '/builds/slave/test', 15:29:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:00 INFO - 'SHELL': '/bin/bash', 15:29:00 INFO - 'SHLVL': '1', 15:29:00 INFO - 'TERM': 'linux', 15:29:00 INFO - 'TMOUT': '86400', 15:29:00 INFO - 'USER': 'cltbld', 15:29:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797', 15:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:00 INFO - '_': '/tools/buildbot/bin/python'} 15:29:00 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/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 15:29:01 INFO - mozversion application_buildid: 20170106162321 15:29:01 INFO - mozversion application_changeset: e7b1d82db69bc147df429a220420e412ff3dbe98 15:29:01 INFO - mozversion application_display_name: Nightly 15:29:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:01 INFO - mozversion application_name: Firefox 15:29:01 INFO - mozversion application_remotingname: firefox 15:29:01 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 15:29:01 INFO - mozversion application_vendor: Mozilla 15:29:01 INFO - mozversion application_version: 53.0a1 15:29:01 INFO - mozversion platform_buildid: 20170106162321 15:29:01 INFO - mozversion platform_changeset: e7b1d82db69bc147df429a220420e412ff3dbe98 15:29:01 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 15:29:01 INFO - mozversion platform_version: 53.0a1 15:29:01 INFO - using testdate: 1483745341 15:29:01 INFO - actual date: 1483745341 15:29:01 INFO - starting webserver on 'localhost:54907' 15:29:01 INFO - SUITE-START | Running 2 tests 15:29:01 INFO - TEST-START | dromaeo_css 15:29:01 INFO - operating with platform_type : linux_ 15:29:01 INFO - Initialising browser for dromaeo_css test... 15:29:01 INFO - TEST-INFO | started process 31294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH2Wnxp/profile http://localhost:54907/getInfo.html) 15:29:01 INFO - PROCESS | 31294 | 1483745341527 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:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 15:29:05 INFO - PROCESS | 31294 | __metrics Screen width/height:1600/1200 15:29:05 INFO - PROCESS | 31294 | colorDepth:24 15:29:05 INFO - PROCESS | 31294 | Browser inner width/height: 1024/697 15:29:05 INFO - PROCESS | 31294 | __metrics 15:29:05 ERROR - PROCESS | 31294 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 15:29:06 INFO - TEST-INFO | 31294: exit 0 15:29:06 INFO - Browser initialized. 15:29:06 INFO - Running cycle 1/1 for dromaeo_css test... 15:29:06 INFO - TEST-INFO | started process 31417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH2Wnxp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:18 INFO - PROCESS | 31417 | RSS: Main: 158191616 15:29:18 INFO - PROCESS | 31417 | 15:30:08 INFO - PROCESS | 31417 | 1483745408209 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:32:22 INFO - PROCESS | 31417 | Cycle 1(1): loaded http://localhost:54907/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54907/tests/dromaeo/cssquery-ext.html) 15:32:23 INFO - PROCESS | 31417 | RSS: Main: 165732352 15:32:23 INFO - PROCESS | 31417 | 15:34:06 INFO - PROCESS | 31417 | ************************* 15:34:06 INFO - PROCESS | 31417 | A coding exception was thrown and uncaught in a Task. 15:34:06 INFO - PROCESS | 31417 | 15:34:06 INFO - PROCESS | 31417 | Full message: ReferenceError: fetch is not defined 15:34:06 INFO - PROCESS | 31417 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 15:34:06 INFO - PROCESS | 31417 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 15:34:06 INFO - PROCESS | 31417 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 15:34:06 INFO - PROCESS | 31417 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:34:06 INFO - PROCESS | 31417 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:34:06 INFO - PROCESS | 31417 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:34:06 INFO - PROCESS | 31417 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 15:34:06 INFO - PROCESS | 31417 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:34:06 INFO - PROCESS | 31417 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:34:06 INFO - PROCESS | 31417 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:34:06 INFO - PROCESS | 31417 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 15:34:06 INFO - PROCESS | 31417 | 15:34:06 INFO - PROCESS | 31417 | ************************* 15:35:26 INFO - PROCESS | 31417 | Cycle 1(1): loaded http://localhost:54907/tests/dromaeo/cssquery-ext.html (next: http://localhost:54907/tests/dromaeo/cssquery-jquery.html) 15:35:26 INFO - PROCESS | 31417 | RSS: Main: 163299328 15:35:26 INFO - PROCESS | 31417 | 15:38:29 INFO - PROCESS | 31417 | Cycle 1(1): loaded http://localhost:54907/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54907/tests/dromaeo/cssquery-mootools.html) 15:38:29 INFO - PROCESS | 31417 | RSS: Main: 167821312 15:38:29 INFO - PROCESS | 31417 | 15:41:31 INFO - PROCESS | 31417 | Cycle 1(1): loaded http://localhost:54907/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54907/tests/dromaeo/cssquery-prototype.html) 15:41:32 INFO - PROCESS | 31417 | RSS: Main: 163168256 15:41:32 INFO - PROCESS | 31417 | 15:44:35 INFO - PROCESS | 31417 | Cycle 1(1): loaded http://localhost:54907/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54907/tests/dromaeo/cssquery-yui.html) 15:44:36 INFO - PROCESS | 31417 | RSS: Main: 166363136 15:44:36 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | Cycle 1(1): loaded http://localhost:54907/tests/dromaeo/cssquery-yui.html (next: http://localhost:54907/tests/dromaeo/cssquery-dojo.html) 15:47:39 INFO - PROCESS | 31417 | RSS: Main: 167034880 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | __start_tp_report 15:47:39 INFO - PROCESS | 31417 | _x_x_mozilla_page_load 15:47:39 INFO - PROCESS | 31417 | _x_x_mozilla_page_load_details 15:47:39 INFO - PROCESS | 31417 | |i|pagename|runs| 15:47:39 INFO - PROCESS | 31417 | |0;dojo.html;2563.564194087005;2576.1498705427207;2578.522973249949;2598.3763896664796;2605.7263987281335;4711.575958163765;4741.90516189676;4793.1132740443045;4811.494793046728;4840.152973229684;4735.763211839411;4795.304680821278;4826.203676393399;4844.491328410519;4912.828051018215;4357.934630980546;4391.516933137353;4415.8233670653135;4458.242098843204;4489.304157855538;4050.432939388488;4507.323901414798;4508.571685689871;4525.683202175849;4525.954740452603;4352.260115780293;4360.825566977317;4375.868723938287;4415.536368681291;4480.6639502037315;4340.479142502888;4371.519132895379;4371.956280437187;4400.427944367212;4466.1067786442845;4365.170617582681;4372.475302963633;4374;4376;4391.429114215131;4709.552592503706;4764.952350476486;4784.545468180518;4796.808127674889;4829.323894654751;4977.626677999165;5018.071656743477;5171.637985341028;5207.531322181022;5211.661242019257;5257.342832145981;5258.07983602868;5265.86835329116;5267.28891599633;5290.312259406252;4900;4909.656324057318;4918.95081049185;4940.407151141886;4962.503749625009;5137.897242055213;5189.351331083614;5191.844244672666;5257.421683614799;5335.599830012687;4960.652754307236;4988.0772057168815;5018.949810501921;5045.823396181189;5048.62135339851;5033.748312584356;5073.898522029539;5099.668521546162;5125.974370128126;5148.665336753099;5022.296878437021;5025.874353141127;5102.260172275073;5119.641625086283;5160.948390516121;5115.028144652504;5122.180451127876;5130.30740849988;5145.151050076695;5146.305248791366;4255.723377980483;4278;4288.592583704605;4324.286492728665;4416.690831641754;3752.587215406303;3769.6041915599017;3797.7721336719887;3812.5234345706785;3826.598207188205;4405.669574781904;4425.579569940851;4427.313766366218;4443.555644435531;4457.910841783211;5137.588992880561;5158.871028224325;5181.274621552986;5188.662736922163;5217.7912883485;4412.448443944507;4430.689851710349;4433.667474939392;4435.800388982503;4479.440069991251;4505.752183629932;4545.613622842029;4546.0680560485025;4585.633149348044;4594.908101838011;4698.248280275139;4727.267273572602;4744.644151688568;4749.548792864673;4751.667383283137;5068.594512438923;5111.642185047011;5114.820981265638;5116.667416617908;5134.281200631989;4789.856304310876;4819.108464933858;4819.49395313487;4846.806127754991;4863.878403039952;5028.195488721787;5097.413797413345;5109.054824857413;5113.054084994288;5156.5616922562;5042.722650254272;5083.034223497523;5183.222516622386;5189.844304670866;5202.063628546746;4983.9003219934675;4990.126727822689;5004.47453017428;5031.169856973705;5072.1123803335;4989.426215985208;5024.874378140576;5027.195648696191;5039.899202016012;5077.390713114302;4897.559219670246;4947.084789313988;4954.355933728592;4976.10430122567;5037.974810125926;5016.698998060128;5033.6476446648385;5051.015052064812;5055.494450554915;5130.871728206825;4927.236278376858;4935.333729946411;4945.2582112683385;4957.776900039435;4980.028894365564 15:47:39 INFO - PROCESS | 31417 | |1;ext.html;526.8261473713675;531.9494648008438;545.920841477986;555.3862981405547;563.9464250896164;39297.607023929755;40532;40590.39114413279;40671.59328406719;40674.796626016905;41700;42403.15193696124;42431;42431.363529547;42505.78747106268;7550.546967181973;7717.768466946;7720.498167619115;7733.033370828646;9592.376495527804;9776.853347199762;9890.67569121256;9897.95051024744;9898.604055837757;9919.90080099197;9818.214542836591;9862.063104005143;9915;9917.404955702645;9923.851142232872;9835.606575736998;9881.308308418413;9889.456079915602;9893.505324733771;9898.158656514204;9720.562574684085;9765.853512197322;9776.120149186607;9781.168600668952;9782.217422606174;34553;34560.82719586386;34579;34802.12994675128;34942;3544.8936531904083;3642.6175251598465;3647.5258216431957;3652.433872749728;3676.522052133232;25862.870685646638;26287.34281642955;26354.73645263542;26440.471190576274;26703.732962670514;3272.5582046423665;3324.335132973391;3338.4157772389735;3371.0561042908025;3379.222778760874;243229;244574;246156;246538;246987.6506174684;46154;46426.535734642894;46478.76760616243;46738;46739.29891051637;48616.27075593869;48978.26532602014;48988.26517602239;49119.754401227765;49170.508294916595;13370.26463544495;13527.256000920044;13655.38550765218;13674.179549227078;13771.380287886868;9368.156865882103;9698.612055517842;10312.793744125076;10469.31949423285;10637.680869573926;15576.688466230838;15582.298796554182;15660.216989150496;15703.136327502098;15717.449889253821;6380.395076781603;6484.76275684888;6637.701303441357;6643.435307998778;6725.899111513331;788.8382881509277;802.4062193976415;802.7230605441114;818.3943881527746;828.3704384667695;26609;27396.863015684794;27914.86042569774;28306.85846570754;28412.715872841007;965.3966271080575;965.7875267441152;987.4201277955215;992.3549692699803;1004.3127545723255;14298.046297490624;14957.925210374096;15047.699046019237;15138.848611513964;15149.318280677175;316642;320366;320720;321531;321729;51708.22437663438;51832.22251666228;52022.47977520252;52181.478185218424;52503.47496525062;1203.4343858386544;1241.0815996162955;1241.782688029591;1244.3031902134653;1248.806435002576;26013.739862601888;26775.464490710467;27027.324316892234;27581.862090689418;27713.86143069272;43114.56885431105;43983.340249895635;44000.33999489946;44044.77977610091;44053.33919991267;294062;296254.0057092265;296297;296590;297611;23148.537029258983;23876.283711488682;23897;24914.252572422858;25527.744722552536;37156.814215928745;37957.24085518329;38113.618863811;38379.424308634836;38433;31610.683893160774;32297.838510807294;32323.676763232066;32663.34673306473;32897.34205315928;32217;32426.189345266557;32591.18522036968;33014;33191;31326.686733132377;31454.685453145175;31626.525602115526;31704.841475792473;32007.519887202176;26747.19758407251;27827;29611.259718507208;29723.405531889675;29774.25564360908;22561.210357637403;22593;22779.544409112055;22871.88564057169;22995.425114372276 15:47:39 INFO - PROCESS | 31417 | |2;jquery.html;356.84833945573143;368.98524059037646;370.16527729968914;377.70538979595926;386.39722033627544;16612.66774664506;17770.200340984655;18141;18142;18158.092095395226;16763.329466821342;17430.47708568745;17510.737338939925;17647.382341618046;17797.199126039326;4605.148047611186;4843.200871856139;4844.878878028042;4847.781849816749;4848.054629347261;4571.085782843428;4675.322078298645;4690.108879312937;4720.669553131283;4769.236922092466;4707.152712511746;4707.693999890013;4712.528747125294;4724.078804633098;4735.337052812609;4572.314152877062;4684.836030738925;4713;4736.9526304736855;4752.1921273383605;4684.648651351163;4691.085238378518;4692.436907571113;4700.29495575663;4722.83470078549;12153.878461215452;12247.387630618434;12292.139550231488;12415.565455209115;12420.503179872794;2250.5723912456583;2281.269993602048;2341.0869760793303;2356.8585884846966;2371.537550177716;8954;9205.769855753593;9249.537523123818;9254.86117708235;9418.152366286999;1729.4292883348464;1743.1458585293242;1785.0450009245121;1786.455131184988;1802;77957;78602;79130;79850;80480.59759701222;9968.302218844612;10187.439690817077;10188.796224075477;10248.38509689421;10255.846162307571;13922.582322530341;13999.580012599637;14003.649908752363;14054.508092216927;14091.436342546183;6950.679370919509;7075.150981882207;7099.290070992859;7111.288871112847;7253;6546.639934803631;6570.868582628321;6607.372299631527;6798.8640227196165;6822.113125293779;4243.257429949808;4282.721623094489;4330.437043184366;4388.253996820485;4455.331700244989;1823.5206290747863;1832.9460560177683;1873.5503479164902;1875.427994461675;1896.2794138227384;783.7061102086717;820.606109067639;823.9629216685264;824.744329257932;858.8754630578532;16140.192990350435;16437.506874793777;16501.174941253128;16573.17134143312;17558.77088603811;807.915168907268;808.1554775259867;813.1096449387911;814.5886327404622;833.2875391540146;9047.502387368759;9367.531623418801;9401.482918439551;9546;9569.665061722806;488421;491408;519705;521888;526748;84880.15119848722;87208.56395717981;87331.56334218288;104588;105234;949.2311227905419;964.6286179820679;986.0484632329836;989.0900371658092;989.3074847606704;15797.36810527566;15830.762538561701;15866.52400427989;16543.586410339358;16803.243854026354;31260.374792504477;35636;39598.80200598978;39909.80045099756;40542.39186412265;57592.424075760384;58499;58995.70502147634;59980;61496.07755883576;7779.922200778146;7880.881786773089;7884.566348850868;7885.369170466234;7961.880571791544;10072;11919.225250359046;12107.455164517794;12190.756184876076;12851;10317.690469285933;10387.807514204202;10635.840462393226;10793.29843560166;10842.457877105955;9992.200623950212;10329.586816527255;10458.163346932379;10539.683809485728;10950.671479855617;7386.482946193715;10226.437545935045;10606;10631;10752.247342685936;7676.270754278558;7740.651670674721;7800.687972481037;7836.177201394;7961.323287520626;8444.704435344733;10427.322224055411;10583.31208471447;10585.9470702646;10744.462776861283 15:47:39 INFO - PROCESS | 31417 | |3;mootools.html;1190.321516735461;1203.8856308650686;1213.6055781870893;1217.3243849663436;1236.2953116723465;6080.878382432349;6273.623582585036;6505.707243174057;6906.861862762742;6920.75777347793;6643.800685979429;6790.388865002149;6823.522353435262;6908.171019477657;7036.366726994569;2034.3998520436508;2083;2087.634663933813;2089.362744362969;2092.184048221195;1784.3754685859974;1846.7783865936105;2038.5005673609987;2097.8531502794813;2101.422108920044;1896.7913529511743;1964.7052942058733;1968.9803101969012;1972.1322618048084;1978.0505357428442;2050.41563154501;2052.107333310015;2068.0590331399253;2069.2550681754556;2073.160370050117;2048.2114385961513;2067.3074520035657;2074.263636409083;2082.2816128435666;2084.739407574053;6831.965840170817;6967.54710943787;6982.2319544850025;6999.82500437488;7002.019717239539;4088.080181959065;4189.706720529564;4227.091175397273;4228.577142285778;4236.0892408132095;2544.300317412708;2728.0997270900557;2741.6024676422007;2743.7804975601903;2750.3674154944474;973.4279139190228;1033.5039181192994;1062.0282441565957;1105.0717397386234;1114.2534501883677;8462.830743385099;8722.86915696265;8724.38929274951;8728;8736.51949142797;3543.362194804908;3678.5401824771902;3701.241245544657;3707.647773461517;3721.423179407196;7007.089078419875;7007.824804379931;7016.438684905297;7022.192447868459;7038.085048943604;4183.037901282662;4218.894527636834;4239.872803815891;4244.129953359554;4253.574642535722;3840.8655697050467;3848.9615103849164;3892.746971446847;3978.622030907059;4007.3988901664984;3078.615173103362;3126.9218269543444;3164.493681011027;3191.1383926340222;3197.4404479216046;924.4869097650868;952.7951490429452;960.5869476125333;965.1410244882061;968.9224862011163;843.7848348671172;854.9914500854912;857.5883575883611;883.9646414143491;883.9701747464132;4688.765561721901;4773.9761301193275;4795.424549054136;4819.6867203631655;4852.684575502581;936.7517607833929;947.346331031586;952.6046690623314;954.8519979403204;969.1132613658424;3448.327576122632;3461.1866211440292;3548.7515873889097;3589.407747721649;3635.1820840311248;8077.192280771993;8204.138565450661;8214.958925205336;8248.257656810916;8303;8093.8381232376205;8163.836723265502;8246.752597422086;8284.337253019745;8301.750947471586;6494.318096599884;6674.532782705164;6684.028211677567;6689.665516724144;6697.765578204837;4810.056032723957;4814.831480898151;4885.877853053702;4980.850574482772;5049.444561098349;7263.891041634485;7416.221296763762;7573.886391704239;7595.278448547379;7622.961885190539;7366.521176123749;7560.092788865371;7611.124720656974;7650.655720492702;7721.961390193013;5946.643201407929;6084.087386892002;6088.208532890873;6111.663858487826;6114.938850611615;6533.444657204191;6610.372014658792;6610.834729131618;6617.933820661732;6646.567973081735;5722.141678748221;5889.970550147222;6007.699615019144;6049.818505444844;6058.151858739692;5898.675572843535;5955.076963070731;5992.880142397041;6027.78902738402;6104.145419641342;5426.647267927572;5492.313460817398;5492.642978206404;5500.477454641803;5508.283923089973;4158.875233742992;4239.660827133884;4290.721103128287;4374.1907747065625;4529.501754807035;4077.286474866827;4194.958050419456;4305.289627211475;4314.590113939171;4378.584034516716 15:47:39 INFO - PROCESS | 31417 | |4;prototype.html;311.826936050492;324.40633640437994;328.7343726652387;340.2854006586171;340.5487728759393;5033.144365457872;5039.344885164924;5083.085044691954;5087.287779710843;5096.974515127428;4984.800607975686;4999.450060493343;5009.724465154415;5021.874453138674;5049.72762256984;3789.275879474846;3812.294725475782;3886.125621735115;3892.6691231245377;3911.2373087247997;3904.9804750976205;3928.4500169976227;3936.1734035852505;3943.487346644932;3944.1914407546383;3900.5124359455067;3908.257431088084;3911.198204368098;3924.313245182096;3929.960700392988;3618.855245790165;3784.6026167252317;3899.181171953893;3924.843006279745;3927.509061367329;3308.156420112856;3322.651121632218;3327.1349449143154;3336.59960804705;3340.3319336132627;4808.206645903457;4832.202686556714;4838.685485443435;4855.150348688965;4867.975660121712;4314.395984562164;4319.978400108011;4328.567143285678;4370.322599997005;4374.8906277343;5101.642884998052;5150;5172.939547392775;5182;5193.272941788153;3631.963680363189;3637.7999210043436;3640.1809592841664;3650.3064417760806;3662.6520480554304;5426.647267927572;5454.554543046096;5476.698781567012;5498.890022199534;5537.169424586345;3563.037979745506;3603.3333833240936;3609.5668519777796;3614.1326081740194;3640.4539319102346;3658.756022952209;3673.430618254175;3678.5953545110015;3687.852485900534;3703.111253299189;4264.189803937242;4268.530461649216;4279.186954478639;4300.268954277781;4305.440292761921;5095.923561146586;5114.2243094802525;5250.343707036621;5276.736163191825;5296.9670914171365;1256.4032084759665;1260.5966090850839;1263.387257180267;1264.8229247905301;1277.916935399196;819.7253919936888;849.668629234599;852.6418904060309;855.6406309350087;864.8486514859875;4390.143921935192;4480.439945006874;4497.415336006298;4498.77506124699;4525.389072475239;5306.681599104066;5355.812546560929;5357;5369.19462080691;5373.865653358697;4513.390692256569;4578.862634120982;4594.897224666056;4595.40259766235;4597.977010114928;2641.696204936457;2681.4905168018013;2708.702042775293;2724.3870129221164;2734.824025668942;4784.928226076611;4794.914212317653;4811.27830825379;4811.831585894547;4843.685160464559;5110.342621836624;5304.575633949275;5310.035286943856;5342.252084708144;5364.8122315718765;4765.833195838129;4789.84456994347;4808.711477311373;4819.373481447459;4827.782749776268;5122.231665250242;5161.380634323905;5173.793048278027;5197.02427642861;5217.321788139277;4981.975090124526;5052.797888084582;5063.948840927317;5068.72122033277;5111.923321150111;4851.393575803025;4928.901421971612;4934.062528119646;4936.679115857602;4985.177445721415;3692.3722967095123;3712.6472985066375;3728.3462207037796;3743.2139250757646;3746.2882052409955;5145.305383773292;5384.461553844584;5390.838274851604;5400.594955378441;5415.160650099241;5169.7673604687125;5172.689638621695;5186.273921650896;5186.740662966912;5199.66202196856;5182.538294310323;5202.271681964452;5212.348456442945;5233.502817232356;5245.580353571781;4994.925076123934;5114.795408183631;5132.692038477703;5153.948460515347;5157.303763991963;5061.367329083864;5181.134791475141;5204;5214.895702085862;5257.4216836147225;5061.215511595708;5087.796488140433;5112.565431938178;5116.590672746246;5122.923156152735 15:47:39 INFO - PROCESS | 31417 | |5;yui.html;641.4707866010542;651.2250421997823;720.0639169080195;735.1839458201397;765.5980610179655;12884.613461596155;13367.06430549862;13375.197488150718;13421.060525763212;13570.864291357084;12953.805692914613;13131.934340328286;13188.14277071992;13227.470901163942;13288.867111328884;786.6027656033694;819.2012787532168;821.9465734727254;826.3348004856089;827.0943317067802;820.3396266005863;822.8930239068943;824.5011767880436;826.1985873702529;826.2935190412201;849.9957500212521;853.036069241756;856.9957150214271;857.2199298638241;857.7941294089436;847.9872801907976;848.499385362636;849.6473963305283;850.0267194062794;851.2296371783546;627.7834147219202;628.2272804450552;628.9748410063592;629.0187307799802;629.3674856768964;12029.097817663624;12038.939805301005;12184.329861857594;12225.572104976283;12768.61694149177;10481.371117732884;10527.420991845445;10627.574897004111;10716.35701857891;10981.39602321872;9344.439333640003;9346.15884570392;9587.616495340179;9654.951725241399;9698.36960597559;3163.2724473371254;3180.2685382361956;3188.681131886816;3195.7762956593047;3210.341879914612;60309.6984515079;61033.694831526;62197.68901155511;62968.68515657393;63297;8131.9593402032615;8137.349012079019;8174.468659537111;8221.958890205511;8230.62962166704;17139.14304284781;17235.31058757661;17265.741013884803;17276.13619319029;17344.306227751;6698;6724.554220842445;6793.06002518538;6797.422219111332;7011.824704382329;3429.228423604719;3522.295540891832;3540.451230059345;3546.7517273791104;3592.6946209571956;2784.4987902177804;2861.8998335058172;2867.168521128891;2908.578256152888;3036.8481575921114;493.67417504446894;518.4452635679862;524.0959345129621;539.5575627985093;546.1670951798538;626.4549841637804;626.7211091064523;638.9073584330246;645.5932762359683;655.7540922154192;7910.604469776488;7986.361091112697;8168.550729709804;8248.876266856001;8655.783605409915;651.6567080409116;667.4160109903834;672.0951273103285;673.8214373191108;679.242644451443;3881.146147847469;3920.5702647657863;4092;4124.876253712393;4236.576342365739;63794;66703.66648166729;67980.6600966992;69167.65416172887;69438.3056169442;57059.71470142623;58015;58202;59993.70003149956;60064.399356006754;56516;56635.15047274294;57230.42769572251;57499.712501438065;57606.7119664399;7704.499207551491;8222;8499.83000340002;8769.736907892773;8783.429077109968;33742.66257337395;34491.31017379688;35235.29529409449;36121.27757444889;36514;46293.768531157126;46499.76750116228;46882;47287.52712472831;47332.2900156491;10432.530536125741;10457.84313235287;10534.57861685524;10695.786084278427;10827.187960902806;12869.549565765154;12922.524381653577;12965.286909220084;13014.674633134247;13891.930540347234;12386.5664701735;12578.622641320775;12590.748185036431;12718.618441446772;12780.744385112432;12610;12704.74590508203;13129.29718294417;13272.80090798658;13442.462301508222;12073.69815754578;12131;12285;12489.125761196992;12951.352432378155;9910.504474776088;9934.652287169914;9973.30186886911;10268.281220314806;10421.478926053514;9397.577109029973;9936.105750482491;10018.899811001796;10068.949655251678;10070.546825392728 15:47:39 INFO - PROCESS | 31417 | __end_tp_report 15:47:39 INFO - PROCESS | 31417 | __start_cc_report 15:47:39 INFO - PROCESS | 31417 | _x_x_mozilla_cycle_collect,331 15:47:39 INFO - PROCESS | 31417 | __end_cc_report 15:47:39 INFO - PROCESS | 31417 | __startTimestamp1483746459307__endTimestamp 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | ------- Summary: start ------- 15:47:39 INFO - PROCESS | 31417 | Number of tests: 6 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | [#0] dojo.html Cycles:165 Average:4741.54 Median:4912.83 stddev:516.92 (10.5%) stddev-sans-first:489.45 15:47:39 INFO - PROCESS | 31417 | Values: 2563.6 2576.1 2578.5 2598.4 2605.7 4711.6 4741.9 4793.1 4811.5 4840.2 4735.8 4795.3 4826.2 4844.5 4912.8 4357.9 4391.5 4415.8 4458.2 4489.3 4050.4 4507.3 4508.6 4525.7 4526.0 4352.3 4360.8 4375.9 4415.5 4480.7 4340.5 4371.5 4372.0 4400.4 4466.1 4365.2 4372.5 4374.0 4376.0 4391.4 4709.6 4765.0 4784.5 4796.8 4829.3 4977.6 5018.1 5171.6 5207.5 5211.7 5257.3 5258.1 5265.9 5267.3 5290.3 4900.0 4909.7 4919.0 4940.4 4962.5 5137.9 5189.4 5191.8 5257.4 5335.6 4960.7 4988.1 5018.9 5045.8 5048.6 5033.7 5073.9 5099.7 5126.0 5148.7 5022.3 5025.9 5102.3 5119.6 5160.9 5115.0 5122.2 5130.3 5145.2 5146.3 4255.7 4278.0 4288.6 4324.3 4416.7 3752.6 3769.6 3797.8 3812.5 3826.6 4405.7 4425.6 4427.3 4443.6 4457.9 5137.6 5158.9 5181.3 5188.7 5217.8 4412.4 4430.7 4433.7 4435.8 4479.4 4505.8 4545.6 4546.1 4585.6 4594.9 4698.2 4727.3 4744.6 4749.5 4751.7 5068.6 5111.6 5114.8 5116.7 5134.3 4789.9 4819.1 4819.5 4846.8 4863.9 5028.2 5097.4 5109.1 5113.1 5156.6 5042.7 5083.0 5183.2 5189.8 5202.1 4983.9 4990.1 5004.5 5031.2 5072.1 4989.4 5024.9 5027.2 5039.9 5077.4 4897.6 4947.1 4954.4 4976.1 5038.0 5016.7 5033.6 5051.0 5055.5 5130.9 4927.2 4935.3 4945.3 4957.8 4980.0 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | [#1] ext.html Cycles:180 Average:43915.08 Median:34569.91 stddev:75647.96 (218.8%) stddev-sans-first:75790.03 15:47:39 INFO - PROCESS | 31417 | Values: 526.8 531.9 545.9 555.4 563.9 39297.6 40532.0 40590.4 40671.6 40674.8 41700.0 42403.2 42431.0 42431.4 42505.8 7550.5 7717.8 7720.5 7733.0 9592.4 9776.9 9890.7 9898.0 9898.6 9919.9 9818.2 9862.1 9915.0 9917.4 9923.9 9835.6 9881.3 9889.5 9893.5 9898.2 9720.6 9765.9 9776.1 9781.2 9782.2 34553.0 34560.8 34579.0 34802.1 34942.0 3544.9 3642.6 3647.5 3652.4 3676.5 25862.9 26287.3 26354.7 26440.5 26703.7 3272.6 3324.3 3338.4 3371.1 3379.2 243229.0 244574.0 246156.0 246538.0 246987.7 46154.0 46426.5 46478.8 46738.0 46739.3 48616.3 48978.3 48988.3 49119.8 49170.5 13370.3 13527.3 13655.4 13674.2 13771.4 9368.2 9698.6 10312.8 10469.3 10637.7 15576.7 15582.3 15660.2 15703.1 15717.4 6380.4 6484.8 6637.7 6643.4 6725.9 788.8 802.4 802.7 818.4 828.4 26609.0 27396.9 27914.9 28306.9 28412.7 965.4 965.8 987.4 992.4 1004.3 14298.0 14957.9 15047.7 15138.8 15149.3 316642.0 320366.0 320720.0 321531.0 321729.0 51708.2 51832.2 52022.5 52181.5 52503.5 1203.4 1241.1 1241.8 1244.3 1248.8 26013.7 26775.5 27027.3 27581.9 27713.9 43114.6 43983.3 44000.3 44044.8 44053.3 294062.0 296254.0 296297.0 296590.0 297611.0 23148.5 23876.3 23897.0 24914.3 25527.7 37156.8 37957.2 38113.6 38379.4 38433.0 31610.7 32297.8 32323.7 32663.3 32897.3 32217.0 32426.2 32591.2 33014.0 33191.0 31326.7 31454.7 31626.5 31704.8 32007.5 26747.2 27827.0 29611.3 29723.4 29774.3 22561.2 22593.0 22779.5 22871.9 22995.4 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | [#2] jquery.html Cycles:180 Average:28382.11 Median:4640.24 stddev:84198.25 (1814.5%) stddev-sans-first:84408.15 15:47:39 INFO - PROCESS | 31417 | Values: 356.8 369.0 370.2 377.7 386.4 16612.7 17770.2 18141.0 18142.0 18158.1 16763.3 17430.5 17510.7 17647.4 17797.2 4605.1 4843.2 4844.9 4847.8 4848.1 4571.1 4675.3 4690.1 4720.7 4769.2 4707.2 4707.7 4712.5 4724.1 4735.3 4572.3 4684.8 4713.0 4737.0 4752.2 4684.6 4691.1 4692.4 4700.3 4722.8 12153.9 12247.4 12292.1 12415.6 12420.5 2250.6 2281.3 2341.1 2356.9 2371.5 8954.0 9205.8 9249.5 9254.9 9418.2 1729.4 1743.1 1785.0 1786.5 1802.0 77957.0 78602.0 79130.0 79850.0 80480.6 9968.3 10187.4 10188.8 10248.4 10255.8 13922.6 13999.6 14003.6 14054.5 14091.4 6950.7 7075.2 7099.3 7111.3 7253.0 6546.6 6570.9 6607.4 6798.9 6822.1 4243.3 4282.7 4330.4 4388.3 4455.3 1823.5 1832.9 1873.6 1875.4 1896.3 783.7 820.6 824.0 824.7 858.9 16140.2 16437.5 16501.2 16573.2 17558.8 807.9 808.2 813.1 814.6 833.3 9047.5 9367.5 9401.5 9546.0 9569.7 488421.0 491408.0 519705.0 521888.0 526748.0 84880.2 87208.6 87331.6 104588.0 105234.0 949.2 964.6 986.0 989.1 989.3 15797.4 15830.8 15866.5 16543.6 16803.2 31260.4 35636.0 39598.8 39909.8 40542.4 57592.4 58499.0 58995.7 59980.0 61496.1 7779.9 7880.9 7884.6 7885.4 7961.9 10072.0 11919.2 12107.5 12190.8 12851.0 10317.7 10387.8 10635.8 10793.3 10842.5 9992.2 10329.6 10458.2 10539.7 10950.7 7386.5 10226.4 10606.0 10631.0 10752.2 7676.3 7740.7 7800.7 7836.2 7961.3 8444.7 10427.3 10583.3 10585.9 10744.5 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | [#3] mootools.html Cycles:180 Average:4531.22 Median:5492.48 stddev:2373.47 (43.2%) stddev-sans-first:2366.85 15:47:39 INFO - PROCESS | 31417 | Values: 1190.3 1203.9 1213.6 1217.3 1236.3 6080.9 6273.6 6505.7 6906.9 6920.8 6643.8 6790.4 6823.5 6908.2 7036.4 2034.4 2083.0 2087.6 2089.4 2092.2 1784.4 1846.8 2038.5 2097.9 2101.4 1896.8 1964.7 1969.0 1972.1 1978.1 2050.4 2052.1 2068.1 2069.3 2073.2 2048.2 2067.3 2074.3 2082.3 2084.7 6832.0 6967.5 6982.2 6999.8 7002.0 4088.1 4189.7 4227.1 4228.6 4236.1 2544.3 2728.1 2741.6 2743.8 2750.4 973.4 1033.5 1062.0 1105.1 1114.3 8462.8 8722.9 8724.4 8728.0 8736.5 3543.4 3678.5 3701.2 3707.6 3721.4 7007.1 7007.8 7016.4 7022.2 7038.1 4183.0 4218.9 4239.9 4244.1 4253.6 3840.9 3849.0 3892.7 3978.6 4007.4 3078.6 3126.9 3164.5 3191.1 3197.4 924.5 952.8 960.6 965.1 968.9 843.8 855.0 857.6 884.0 884.0 4688.8 4774.0 4795.4 4819.7 4852.7 936.8 947.3 952.6 954.9 969.1 3448.3 3461.2 3548.8 3589.4 3635.2 8077.2 8204.1 8215.0 8248.3 8303.0 8093.8 8163.8 8246.8 8284.3 8301.8 6494.3 6674.5 6684.0 6689.7 6697.8 4810.1 4814.8 4885.9 4980.9 5049.4 7263.9 7416.2 7573.9 7595.3 7623.0 7366.5 7560.1 7611.1 7650.7 7722.0 5946.6 6084.1 6088.2 6111.7 6114.9 6533.4 6610.4 6610.8 6617.9 6646.6 5722.1 5890.0 6007.7 6049.8 6058.2 5898.7 5955.1 5992.9 6027.8 6104.1 5426.6 5492.3 5492.6 5500.5 5508.3 4158.9 4239.7 4290.7 4374.2 4529.5 4077.3 4195.0 4305.3 4314.6 4378.6 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | [#4] prototype.html Cycles:180 Average:4268.16 Median:4835.44 stddev:1254.38 (25.9%) stddev-sans-first:1222.25 15:47:39 INFO - PROCESS | 31417 | Values: 311.8 324.4 328.7 340.3 340.5 5033.1 5039.3 5083.1 5087.3 5097.0 4984.8 4999.5 5009.7 5021.9 5049.7 3789.3 3812.3 3886.1 3892.7 3911.2 3905.0 3928.5 3936.2 3943.5 3944.2 3900.5 3908.3 3911.2 3924.3 3930.0 3618.9 3784.6 3899.2 3924.8 3927.5 3308.2 3322.7 3327.1 3336.6 3340.3 4808.2 4832.2 4838.7 4855.2 4868.0 4314.4 4320.0 4328.6 4370.3 4374.9 5101.6 5150.0 5172.9 5182.0 5193.3 3632.0 3637.8 3640.2 3650.3 3662.7 5426.6 5454.6 5476.7 5498.9 5537.2 3563.0 3603.3 3609.6 3614.1 3640.5 3658.8 3673.4 3678.6 3687.9 3703.1 4264.2 4268.5 4279.2 4300.3 4305.4 5095.9 5114.2 5250.3 5276.7 5297.0 1256.4 1260.6 1263.4 1264.8 1277.9 819.7 849.7 852.6 855.6 864.8 4390.1 4480.4 4497.4 4498.8 4525.4 5306.7 5355.8 5357.0 5369.2 5373.9 4513.4 4578.9 4594.9 4595.4 4598.0 2641.7 2681.5 2708.7 2724.4 2734.8 4784.9 4794.9 4811.3 4811.8 4843.7 5110.3 5304.6 5310.0 5342.3 5364.8 4765.8 4789.8 4808.7 4819.4 4827.8 5122.2 5161.4 5173.8 5197.0 5217.3 4982.0 5052.8 5063.9 5068.7 5111.9 4851.4 4928.9 4934.1 4936.7 4985.2 3692.4 3712.6 3728.3 3743.2 3746.3 5145.3 5384.5 5390.8 5400.6 5415.2 5169.8 5172.7 5186.3 5186.7 5199.7 5182.5 5202.3 5212.3 5233.5 5245.6 4994.9 5114.8 5132.7 5153.9 5157.3 5061.4 5181.1 5204.0 5214.9 5257.4 5061.2 5087.8 5112.6 5116.6 5122.9 15:47:39 INFO - PROCESS | 31417 | 15:47:39 INFO - PROCESS | 31417 | [#5] yui.html Cycles:180 Average:14913.60 Median:56575.58 stddev:18907.01 (33.4%) stddev-sans-first:18929.68 15:47:39 INFO - PROCESS | 31417 | Values: 641.5 651.2 720.1 735.2 765.6 12884.6 13367.1 13375.2 13421.1 13570.9 12953.8 13131.9 13188.1 13227.5 13288.9 786.6 819.2 821.9 826.3 827.1 820.3 822.9 824.5 826.2 826.3 850.0 853.0 857.0 857.2 857.8 848.0 848.5 849.6 850.0 851.2 627.8 628.2 629.0 629.0 629.4 12029.1 12038.9 12184.3 12225.6 12768.6 10481.4 10527.4 10627.6 10716.4 10981.4 9344.4 9346.2 9587.6 9655.0 9698.4 3163.3 3180.3 3188.7 3195.8 3210.3 60309.7 61033.7 62197.7 62968.7 63297.0 8132.0 8137.3 8174.5 8222.0 8230.6 17139.1 17235.3 17265.7 17276.1 17344.3 6698.0 6724.6 6793.1 6797.4 7011.8 3429.2 3522.3 3540.5 3546.8 3592.7 2784.5 2861.9 2867.2 2908.6 3036.8 493.7 518.4 524.1 539.6 546.2 626.5 626.7 638.9 645.6 655.8 7910.6 7986.4 8168.6 8248.9 8655.8 651.7 667.4 672.1 673.8 679.2 3881.1 3920.6 4092.0 4124.9 4236.6 63794.0 66703.7 67980.7 69167.7 69438.3 57059.7 58015.0 58202.0 59993.7 60064.4 56516.0 56635.2 57230.4 57499.7 57606.7 7704.5 8222.0 8499.8 8769.7 8783.4 33742.7 34491.3 35235.3 36121.3 36514.0 46293.8 46499.8 46882.0 47287.5 47332.3 10432.5 10457.8 10534.6 10695.8 10827.2 12869.5 12922.5 12965.3 13014.7 13891.9 12386.6 12578.6 12590.7 12718.6 12780.7 12610.0 12704.7 13129.3 13272.8 13442.5 12073.7 12131.0 12285.0 12489.1 12951.4 9910.5 9934.7 9973.3 10268.3 10421.5 9397.6 9936.1 10018.9 10068.9 10070.5 15:47:39 INFO - PROCESS | 31417 | -------- Summary: end -------- 15:47:39 INFO - PROCESS | 31417 | 15:47:40 INFO - TEST-INFO | 31417: exit 0 15:47:40 INFO - TEST-OK | dromaeo_css | took 1119123ms 15:47:40 INFO - TEST-START | kraken 15:47:40 INFO - operating with platform_type : linux_ 15:47:40 INFO - Initialising browser for kraken test... 15:47:40 INFO - TEST-INFO | started process 31767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJqFhsf/profile http://localhost:54907/getInfo.html) 15:47:40 INFO - PROCESS | 31767 | 1483746460625 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:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 15:47:44 INFO - PROCESS | 31767 | __metrics Screen width/height:1600/1200 15:47:44 INFO - PROCESS | 31767 | colorDepth:24 15:47:44 INFO - PROCESS | 31767 | Browser inner width/height: 1024/697 15:47:44 INFO - PROCESS | 31767 | __metrics 15:47:44 ERROR - PROCESS | 31767 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 15:47:45 INFO - TEST-INFO | 31767: exit 0 15:47:45 INFO - Browser initialized. 15:47:45 INFO - Running cycle 1/1 for kraken test... 15:47:45 INFO - TEST-INFO | started process 31887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJqFhsf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:57 INFO - PROCESS | 31887 | RSS: Main: 158564352 15:47:57 INFO - PROCESS | 31887 | 15:48:00 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54907/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:01 INFO - PROCESS | 31887 | RSS: Main: 164175872 15:48:01 INFO - PROCESS | 31887 | 15:48:04 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54907/tests/kraken/driver.html?testName=audio-dft) 15:48:05 INFO - PROCESS | 31887 | RSS: Main: 162865152 15:48:05 INFO - PROCESS | 31887 | 15:48:07 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54907/tests/kraken/driver.html?testName=audio-fft) 15:48:08 INFO - PROCESS | 31887 | RSS: Main: 159485952 15:48:08 INFO - PROCESS | 31887 | 15:48:10 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54907/tests/kraken/driver.html?testName=audio-oscillator) 15:48:11 INFO - PROCESS | 31887 | RSS: Main: 160194560 15:48:11 INFO - PROCESS | 31887 | 15:48:13 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54907/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:14 INFO - PROCESS | 31887 | RSS: Main: 160575488 15:48:14 INFO - PROCESS | 31887 | 15:48:17 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54907/tests/kraken/driver.html?testName=imaging-darkroom) 15:48:17 INFO - PROCESS | 31887 | RSS: Main: 165912576 15:48:17 INFO - PROCESS | 31887 | 15:48:21 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54907/tests/kraken/driver.html?testName=imaging-desaturate) 15:48:22 INFO - PROCESS | 31887 | RSS: Main: 162492416 15:48:22 INFO - PROCESS | 31887 | 15:48:25 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54907/tests/kraken/driver.html?testName=json-parse-financial) 15:48:25 INFO - PROCESS | 31887 | RSS: Main: 162910208 15:48:25 INFO - PROCESS | 31887 | 15:48:27 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54907/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:48:28 INFO - PROCESS | 31887 | RSS: Main: 163282944 15:48:28 INFO - PROCESS | 31887 | 15:48:29 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:30 INFO - PROCESS | 31887 | RSS: Main: 163082240 15:48:30 INFO - PROCESS | 31887 | 15:48:32 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:33 INFO - PROCESS | 31887 | RSS: Main: 163360768 15:48:33 INFO - PROCESS | 31887 | 15:48:36 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:37 INFO - PROCESS | 31887 | RSS: Main: 163356672 15:48:37 INFO - PROCESS | 31887 | 15:48:40 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:40 INFO - PROCESS | 31887 | RSS: Main: 166748160 15:48:40 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:54907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54907/tests/kraken/driver.html?testName=ai-astar) 15:48:42 INFO - PROCESS | 31887 | RSS: Main: 167591936 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | __start_tp_report 15:48:42 INFO - PROCESS | 31887 | _x_x_mozilla_page_load 15:48:42 INFO - PROCESS | 31887 | _x_x_mozilla_page_load_details 15:48:42 INFO - PROCESS | 31887 | |i|pagename|runs| 15:48:42 INFO - PROCESS | 31887 | |0;ai-astar;107;116;118;117;117;116;116;117;117;117 15:48:42 INFO - PROCESS | 31887 | |1;audio-beat-detection;155;125;125;172;130;125;126;126;153;136 15:48:42 INFO - PROCESS | 31887 | |2;audio-dft;164;167;174;165;162;162;165;163;165;163 15:48:42 INFO - PROCESS | 31887 | |3;audio-fft;77;76;76;103;78;77;75;77;102;77 15:48:42 INFO - PROCESS | 31887 | |4;audio-oscillator;85;85;113;85;86;84;97;85;85;101 15:48:42 INFO - PROCESS | 31887 | |5;imaging-gaussian-blur;117;119;118;118;118;121;118;118;119;119 15:48:42 INFO - PROCESS | 31887 | |6;imaging-darkroom;151;150;151;150;150;152;151;150;151;150 15:48:42 INFO - PROCESS | 31887 | |7;imaging-desaturate;95;96;96;96;95;98;96;96;96;96 15:48:42 INFO - PROCESS | 31887 | |8;json-parse-financial;68;67;68;67;70;68;69;70;68;68 15:48:42 INFO - PROCESS | 31887 | |9;json-stringify-tinderbox;66;67;68;67;68;68;67;67;67;67 15:48:42 INFO - PROCESS | 31887 | |10;stanford-crypto-aes;84;84;86;84;84;85;84;84;90;84 15:48:42 INFO - PROCESS | 31887 | |11;stanford-crypto-ccm;138;146;141;151;137;137;145;136;191;150 15:48:42 INFO - PROCESS | 31887 | |12;stanford-crypto-pbkdf2;178;181;180;175;177;177;177;180;187;181 15:48:42 INFO - PROCESS | 31887 | |13;stanford-crypto-sha256-iterative;70;72;70;69;69;69;74;71;70;72 15:48:42 INFO - PROCESS | 31887 | __end_tp_report 15:48:42 INFO - PROCESS | 31887 | __start_cc_report 15:48:42 INFO - PROCESS | 31887 | _x_x_mozilla_cycle_collect,801 15:48:42 INFO - PROCESS | 31887 | __end_cc_report 15:48:42 INFO - PROCESS | 31887 | __startTimestamp1483746522718__endTimestamp 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | ------- Summary: start ------- 15:48:42 INFO - PROCESS | 31887 | Number of tests: 14 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:3.16 (2.7%) stddev-sans-first:0.67 15:48:42 INFO - PROCESS | 31887 | Values: 107.0 116.0 118.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:133.00 stddev:16.76 (12.6%) stddev-sans-first:16.51 15:48:42 INFO - PROCESS | 31887 | Values: 155.0 125.0 125.0 172.0 130.0 125.0 126.0 126.0 153.0 136.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.53 (2.1%) stddev-sans-first:3.72 15:48:42 INFO - PROCESS | 31887 | Values: 164.0 167.0 174.0 165.0 162.0 162.0 165.0 163.0 165.0 163.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:10.94 (14.2%) stddev-sans-first:11.47 15:48:42 INFO - PROCESS | 31887 | Values: 77.0 76.0 76.0 103.0 78.0 77.0 75.0 77.0 102.0 77.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:85.00 stddev:9.85 (11.6%) stddev-sans-first:10.23 15:48:42 INFO - PROCESS | 31887 | Values: 85.0 85.0 113.0 85.0 86.0 84.0 97.0 85.0 85.0 101.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.08 (0.9%) stddev-sans-first:1.00 15:48:42 INFO - PROCESS | 31887 | Values: 117.0 119.0 118.0 118.0 118.0 121.0 118.0 118.0 119.0 119.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:48:42 INFO - PROCESS | 31887 | Values: 151.0 150.0 151.0 150.0 150.0 152.0 151.0 150.0 151.0 150.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 15:48:42 INFO - PROCESS | 31887 | Values: 95.0 96.0 96.0 96.0 95.0 98.0 96.0 96.0 96.0 96.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 15:48:42 INFO - PROCESS | 31887 | Values: 68.0 67.0 68.0 67.0 70.0 68.0 69.0 70.0 68.0 68.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 15:48:42 INFO - PROCESS | 31887 | Values: 66.0 67.0 68.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:1.91 (2.3%) stddev-sans-first:2.00 15:48:42 INFO - PROCESS | 31887 | Values: 84.0 84.0 86.0 84.0 84.0 85.0 84.0 84.0 90.0 84.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:145.50 stddev:16.34 (11.2%) stddev-sans-first:16.99 15:48:42 INFO - PROCESS | 31887 | Values: 138.0 146.0 141.0 151.0 137.0 137.0 145.0 136.0 191.0 150.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:180.00 stddev:3.37 (1.9%) stddev-sans-first:3.54 15:48:42 INFO - PROCESS | 31887 | Values: 178.0 181.0 180.0 175.0 177.0 177.0 177.0 180.0 187.0 181.0 15:48:42 INFO - PROCESS | 31887 | 15:48:42 INFO - PROCESS | 31887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.65 (2.3%) stddev-sans-first:1.73 15:48:42 INFO - PROCESS | 31887 | Values: 70.0 72.0 70.0 69.0 69.0 69.0 74.0 71.0 70.0 72.0 15:48:42 INFO - PROCESS | 31887 | -------- Summary: end -------- 15:48:42 INFO - PROCESS | 31887 | 15:48:43 INFO - TEST-INFO | 31887: exit 0 15:48:43 INFO - TEST-OK | kraken | took 63683ms 15:48:43 INFO - SUITE-END | took 1182s 15:48:43 INFO - Completed test suite (00:19:42) 15:48:43 INFO - javascript benchmark 15:48:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6267.46947574773, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2563.564194087005, 2576.1498705427207, 2578.522973249949, 2598.3763896664796, 2605.7263987281335, 4711.575958163765, 4741.90516189676, 4793.1132740443045, 4811.494793046728, 4840.152973229684, 4735.763211839411, 4795.304680821278, 4826.203676393399, 4844.491328410519, 4912.828051018215, 4357.934630980546, 4391.516933137353, 4415.8233670653135, 4458.242098843204, 4489.304157855538, 4050.432939388488, 4507.323901414798, 4508.571685689871, 4525.683202175849, 4525.954740452603, 4352.260115780293, 4360.825566977317, 4375.868723938287, 4415.536368681291, 4480.6639502037315, 4340.479142502888, 4371.519132895379, 4371.956280437187, 4400.427944367212, 4466.1067786442845, 4365.170617582681, 4372.475302963633, 4374.0, 4376.0, 4391.429114215131, 4709.552592503706, 4764.952350476486, 4784.545468180518, 4796.808127674889, 4829.323894654751, 4977.626677999165, 5018.071656743477, 5171.637985341028, 5207.531322181022, 5211.661242019257, 5257.342832145981, 5258.07983602868, 5265.86835329116, 5267.28891599633, 5290.312259406252, 4900.0, 4909.656324057318, 4918.95081049185, 4940.407151141886, 4962.503749625009, 5137.897242055213, 5189.351331083614, 5191.844244672666, 5257.421683614799, 5335.599830012687, 4960.652754307236, 4988.0772057168815, 5018.949810501921, 5045.823396181189, 5048.62135339851, 5033.748312584356, 5073.898522029539, 5099.668521546162, 5125.974370128126, 5148.665336753099, 5022.296878437021, 5025.874353141127, 5102.260172275073, 5119.641625086283, 5160.948390516121, 5115.028144652504, 5122.180451127876, 5130.30740849988, 5145.151050076695, 5146.305248791366, 4255.723377980483, 4278.0, 4288.592583704605, 4324.286492728665, 4416.690831641754, 3752.587215406303, 3769.6041915599017, 3797.7721336719887, 3812.5234345706785, 3826.598207188205, 4405.669574781904, 4425.579569940851, 4427.313766366218, 4443.555644435531, 4457.910841783211, 5137.588992880561, 5158.871028224325, 5181.274621552986, 5188.662736922163, 5217.7912883485, 4412.448443944507, 4430.689851710349, 4433.667474939392, 4435.800388982503, 4479.440069991251, 4505.752183629932, 4545.613622842029, 4546.0680560485025, 4585.633149348044, 4594.908101838011, 4698.248280275139, 4727.267273572602, 4744.644151688568, 4749.548792864673, 4751.667383283137, 5068.594512438923, 5111.642185047011, 5114.820981265638, 5116.667416617908, 5134.281200631989, 4789.856304310876, 4819.108464933858, 4819.49395313487, 4846.806127754991, 4863.878403039952, 5028.195488721787, 5097.413797413345, 5109.054824857413, 5113.054084994288, 5156.5616922562, 5042.722650254272, 5083.034223497523, 5183.222516622386, 5189.844304670866, 5202.063628546746, 4983.9003219934675, 4990.126727822689, 5004.47453017428, 5031.169856973705, 5072.1123803335, 4989.426215985208, 5024.874378140576, 5027.195648696191, 5039.899202016012, 5077.390713114302, 4897.559219670246, 4947.084789313988, 4954.355933728592, 4976.10430122567, 5037.974810125926, 5016.698998060128, 5033.6476446648385, 5051.015052064812, 5055.494450554915, 5130.871728206825, 4927.236278376858, 4935.333729946411, 4945.2582112683385, 4957.776900039435, 4980.028894365564], "value": 4706.730898041554, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.8261473713675, 531.9494648008438, 545.920841477986, 555.3862981405547, 563.9464250896164, 39297.607023929755, 40532.0, 40590.39114413279, 40671.59328406719, 40674.796626016905, 41700.0, 42403.15193696124, 42431.0, 42431.363529547, 42505.78747106268, 7550.546967181973, 7717.768466946, 7720.498167619115, 7733.033370828646, 9592.376495527804, 9776.853347199762, 9890.67569121256, 9897.95051024744, 9898.604055837757, 9919.90080099197, 9818.214542836591, 9862.063104005143, 9915.0, 9917.404955702645, 9923.851142232872, 9835.606575736998, 9881.308308418413, 9889.456079915602, 9893.505324733771, 9898.158656514204, 9720.562574684085, 9765.853512197322, 9776.120149186607, 9781.168600668952, 9782.217422606174, 34553.0, 34560.82719586386, 34579.0, 34802.12994675128, 34942.0, 3544.8936531904083, 3642.6175251598465, 3647.5258216431957, 3652.433872749728, 3676.522052133232, 25862.870685646638, 26287.34281642955, 26354.73645263542, 26440.471190576274, 26703.732962670514, 3272.5582046423665, 3324.335132973391, 3338.4157772389735, 3371.0561042908025, 3379.222778760874, 243229.0, 244574.0, 246156.0, 246538.0, 246987.6506174684, 46154.0, 46426.535734642894, 46478.76760616243, 46738.0, 46739.29891051637, 48616.27075593869, 48978.26532602014, 48988.26517602239, 49119.754401227765, 49170.508294916595, 13370.26463544495, 13527.256000920044, 13655.38550765218, 13674.179549227078, 13771.380287886868, 9368.156865882103, 9698.612055517842, 10312.793744125076, 10469.31949423285, 10637.680869573926, 15576.688466230838, 15582.298796554182, 15660.216989150496, 15703.136327502098, 15717.449889253821, 6380.395076781603, 6484.76275684888, 6637.701303441357, 6643.435307998778, 6725.899111513331, 788.8382881509277, 802.4062193976415, 802.7230605441114, 818.3943881527746, 828.3704384667695, 26609.0, 27396.863015684794, 27914.86042569774, 28306.85846570754, 28412.715872841007, 965.3966271080575, 965.7875267441152, 987.4201277955215, 992.3549692699803, 1004.3127545723255, 14298.046297490624, 14957.925210374096, 15047.699046019237, 15138.848611513964, 15149.318280677175, 316642.0, 320366.0, 320720.0, 321531.0, 321729.0, 51708.22437663438, 51832.22251666228, 52022.47977520252, 52181.478185218424, 52503.47496525062, 1203.4343858386544, 1241.0815996162955, 1241.782688029591, 1244.3031902134653, 1248.806435002576, 26013.739862601888, 26775.464490710467, 27027.324316892234, 27581.862090689418, 27713.86143069272, 43114.56885431105, 43983.340249895635, 44000.33999489946, 44044.77977610091, 44053.33919991267, 294062.0, 296254.0057092265, 296297.0, 296590.0, 297611.0, 23148.537029258983, 23876.283711488682, 23897.0, 24914.252572422858, 25527.744722552536, 37156.814215928745, 37957.24085518329, 38113.618863811, 38379.424308634836, 38433.0, 31610.683893160774, 32297.838510807294, 32323.676763232066, 32663.34673306473, 32897.34205315928, 32217.0, 32426.189345266557, 32591.18522036968, 33014.0, 33191.0, 31326.686733132377, 31454.685453145175, 31626.525602115526, 31704.841475792473, 32007.519887202176, 26747.19758407251, 27827.0, 29611.259718507208, 29723.405531889675, 29774.25564360908, 22561.210357637403, 22593.0, 22779.544409112055, 22871.88564057169, 22995.425114372276], "value": 17194.020187924278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.84833945573143, 368.98524059037646, 370.16527729968914, 377.70538979595926, 386.39722033627544, 16612.66774664506, 17770.200340984655, 18141.0, 18142.0, 18158.092095395226, 16763.329466821342, 17430.47708568745, 17510.737338939925, 17647.382341618046, 17797.199126039326, 4605.148047611186, 4843.200871856139, 4844.878878028042, 4847.781849816749, 4848.054629347261, 4571.085782843428, 4675.322078298645, 4690.108879312937, 4720.669553131283, 4769.236922092466, 4707.152712511746, 4707.693999890013, 4712.528747125294, 4724.078804633098, 4735.337052812609, 4572.314152877062, 4684.836030738925, 4713.0, 4736.9526304736855, 4752.1921273383605, 4684.648651351163, 4691.085238378518, 4692.436907571113, 4700.29495575663, 4722.83470078549, 12153.878461215452, 12247.387630618434, 12292.139550231488, 12415.565455209115, 12420.503179872794, 2250.5723912456583, 2281.269993602048, 2341.0869760793303, 2356.8585884846966, 2371.537550177716, 8954.0, 9205.769855753593, 9249.537523123818, 9254.86117708235, 9418.152366286999, 1729.4292883348464, 1743.1458585293242, 1785.0450009245121, 1786.455131184988, 1802.0, 77957.0, 78602.0, 79130.0, 79850.0, 80480.59759701222, 9968.302218844612, 10187.439690817077, 10188.796224075477, 10248.38509689421, 10255.846162307571, 13922.582322530341, 13999.580012599637, 14003.649908752363, 14054.508092216927, 14091.436342546183, 6950.679370919509, 7075.150981882207, 7099.290070992859, 7111.288871112847, 7253.0, 6546.639934803631, 6570.868582628321, 6607.372299631527, 6798.8640227196165, 6822.113125293779, 4243.257429949808, 4282.721623094489, 4330.437043184366, 4388.253996820485, 4455.331700244989, 1823.5206290747863, 1832.9460560177683, 1873.5503479164902, 1875.427994461675, 1896.2794138227384, 783.7061102086717, 820.606109067639, 823.9629216685264, 824.744329257932, 858.8754630578532, 16140.192990350435, 16437.506874793777, 16501.174941253128, 16573.17134143312, 17558.77088603811, 807.915168907268, 808.1554775259867, 813.1096449387911, 814.5886327404622, 833.2875391540146, 9047.502387368759, 9367.531623418801, 9401.482918439551, 9546.0, 9569.665061722806, 488421.0, 491408.0, 519705.0, 521888.0, 526748.0, 84880.15119848722, 87208.56395717981, 87331.56334218288, 104588.0, 105234.0, 949.2311227905419, 964.6286179820679, 986.0484632329836, 989.0900371658092, 989.3074847606704, 15797.36810527566, 15830.762538561701, 15866.52400427989, 16543.586410339358, 16803.243854026354, 31260.374792504477, 35636.0, 39598.80200598978, 39909.80045099756, 40542.39186412265, 57592.424075760384, 58499.0, 58995.70502147634, 59980.0, 61496.07755883576, 7779.922200778146, 7880.881786773089, 7884.566348850868, 7885.369170466234, 7961.880571791544, 10072.0, 11919.225250359046, 12107.455164517794, 12190.756184876076, 12851.0, 10317.690469285933, 10387.807514204202, 10635.840462393226, 10793.29843560166, 10842.457877105955, 9992.200623950212, 10329.586816527255, 10458.163346932379, 10539.683809485728, 10950.671479855617, 7386.482946193715, 10226.437545935045, 10606.0, 10631.0, 10752.247342685936, 7676.270754278558, 7740.651670674721, 7800.687972481037, 7836.177201394, 7961.323287520626, 8444.704435344733, 10427.322224055411, 10583.31208471447, 10585.9470702646, 10744.462776861283], "value": 8195.590576282932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.321516735461, 1203.8856308650686, 1213.6055781870893, 1217.3243849663436, 1236.2953116723465, 6080.878382432349, 6273.623582585036, 6505.707243174057, 6906.861862762742, 6920.75777347793, 6643.800685979429, 6790.388865002149, 6823.522353435262, 6908.171019477657, 7036.366726994569, 2034.3998520436508, 2083.0, 2087.634663933813, 2089.362744362969, 2092.184048221195, 1784.3754685859974, 1846.7783865936105, 2038.5005673609987, 2097.8531502794813, 2101.422108920044, 1896.7913529511743, 1964.7052942058733, 1968.9803101969012, 1972.1322618048084, 1978.0505357428442, 2050.41563154501, 2052.107333310015, 2068.0590331399253, 2069.2550681754556, 2073.160370050117, 2048.2114385961513, 2067.3074520035657, 2074.263636409083, 2082.2816128435666, 2084.739407574053, 6831.965840170817, 6967.54710943787, 6982.2319544850025, 6999.82500437488, 7002.019717239539, 4088.080181959065, 4189.706720529564, 4227.091175397273, 4228.577142285778, 4236.0892408132095, 2544.300317412708, 2728.0997270900557, 2741.6024676422007, 2743.7804975601903, 2750.3674154944474, 973.4279139190228, 1033.5039181192994, 1062.0282441565957, 1105.0717397386234, 1114.2534501883677, 8462.830743385099, 8722.86915696265, 8724.38929274951, 8728.0, 8736.51949142797, 3543.362194804908, 3678.5401824771902, 3701.241245544657, 3707.647773461517, 3721.423179407196, 7007.089078419875, 7007.824804379931, 7016.438684905297, 7022.192447868459, 7038.085048943604, 4183.037901282662, 4218.894527636834, 4239.872803815891, 4244.129953359554, 4253.574642535722, 3840.8655697050467, 3848.9615103849164, 3892.746971446847, 3978.622030907059, 4007.3988901664984, 3078.615173103362, 3126.9218269543444, 3164.493681011027, 3191.1383926340222, 3197.4404479216046, 924.4869097650868, 952.7951490429452, 960.5869476125333, 965.1410244882061, 968.9224862011163, 843.7848348671172, 854.9914500854912, 857.5883575883611, 883.9646414143491, 883.9701747464132, 4688.765561721901, 4773.9761301193275, 4795.424549054136, 4819.6867203631655, 4852.684575502581, 936.7517607833929, 947.346331031586, 952.6046690623314, 954.8519979403204, 969.1132613658424, 3448.327576122632, 3461.1866211440292, 3548.7515873889097, 3589.407747721649, 3635.1820840311248, 8077.192280771993, 8204.138565450661, 8214.958925205336, 8248.257656810916, 8303.0, 8093.8381232376205, 8163.836723265502, 8246.752597422086, 8284.337253019745, 8301.750947471586, 6494.318096599884, 6674.532782705164, 6684.028211677567, 6689.665516724144, 6697.765578204837, 4810.056032723957, 4814.831480898151, 4885.877853053702, 4980.850574482772, 5049.444561098349, 7263.891041634485, 7416.221296763762, 7573.886391704239, 7595.278448547379, 7622.961885190539, 7366.521176123749, 7560.092788865371, 7611.124720656974, 7650.655720492702, 7721.961390193013, 5946.643201407929, 6084.087386892002, 6088.208532890873, 6111.663858487826, 6114.938850611615, 6533.444657204191, 6610.372014658792, 6610.834729131618, 6617.933820661732, 6646.567973081735, 5722.141678748221, 5889.970550147222, 6007.699615019144, 6049.818505444844, 6058.151858739692, 5898.675572843535, 5955.076963070731, 5992.880142397041, 6027.78902738402, 6104.145419641342, 5426.647267927572, 5492.313460817398, 5492.642978206404, 5500.477454641803, 5508.283923089973, 4158.875233742992, 4239.660827133884, 4290.721103128287, 4374.1907747065625, 4529.501754807035, 4077.286474866827, 4194.958050419456, 4305.289627211475, 4314.590113939171, 4378.584034516716], "value": 3743.283415511654, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.826936050492, 324.40633640437994, 328.7343726652387, 340.2854006586171, 340.5487728759393, 5033.144365457872, 5039.344885164924, 5083.085044691954, 5087.287779710843, 5096.974515127428, 4984.800607975686, 4999.450060493343, 5009.724465154415, 5021.874453138674, 5049.72762256984, 3789.275879474846, 3812.294725475782, 3886.125621735115, 3892.6691231245377, 3911.2373087247997, 3904.9804750976205, 3928.4500169976227, 3936.1734035852505, 3943.487346644932, 3944.1914407546383, 3900.5124359455067, 3908.257431088084, 3911.198204368098, 3924.313245182096, 3929.960700392988, 3618.855245790165, 3784.6026167252317, 3899.181171953893, 3924.843006279745, 3927.509061367329, 3308.156420112856, 3322.651121632218, 3327.1349449143154, 3336.59960804705, 3340.3319336132627, 4808.206645903457, 4832.202686556714, 4838.685485443435, 4855.150348688965, 4867.975660121712, 4314.395984562164, 4319.978400108011, 4328.567143285678, 4370.322599997005, 4374.8906277343, 5101.642884998052, 5150.0, 5172.939547392775, 5182.0, 5193.272941788153, 3631.963680363189, 3637.7999210043436, 3640.1809592841664, 3650.3064417760806, 3662.6520480554304, 5426.647267927572, 5454.554543046096, 5476.698781567012, 5498.890022199534, 5537.169424586345, 3563.037979745506, 3603.3333833240936, 3609.5668519777796, 3614.1326081740194, 3640.4539319102346, 3658.756022952209, 3673.430618254175, 3678.5953545110015, 3687.852485900534, 3703.111253299189, 4264.189803937242, 4268.530461649216, 4279.186954478639, 4300.268954277781, 4305.440292761921, 5095.923561146586, 5114.2243094802525, 5250.343707036621, 5276.736163191825, 5296.9670914171365, 1256.4032084759665, 1260.5966090850839, 1263.387257180267, 1264.8229247905301, 1277.916935399196, 819.7253919936888, 849.668629234599, 852.6418904060309, 855.6406309350087, 864.8486514859875, 4390.143921935192, 4480.439945006874, 4497.415336006298, 4498.77506124699, 4525.389072475239, 5306.681599104066, 5355.812546560929, 5357.0, 5369.19462080691, 5373.865653358697, 4513.390692256569, 4578.862634120982, 4594.897224666056, 4595.40259766235, 4597.977010114928, 2641.696204936457, 2681.4905168018013, 2708.702042775293, 2724.3870129221164, 2734.824025668942, 4784.928226076611, 4794.914212317653, 4811.27830825379, 4811.831585894547, 4843.685160464559, 5110.342621836624, 5304.575633949275, 5310.035286943856, 5342.252084708144, 5364.8122315718765, 4765.833195838129, 4789.84456994347, 4808.711477311373, 4819.373481447459, 4827.782749776268, 5122.231665250242, 5161.380634323905, 5173.793048278027, 5197.02427642861, 5217.321788139277, 4981.975090124526, 5052.797888084582, 5063.948840927317, 5068.72122033277, 5111.923321150111, 4851.393575803025, 4928.901421971612, 4934.062528119646, 4936.679115857602, 4985.177445721415, 3692.3722967095123, 3712.6472985066375, 3728.3462207037796, 3743.2139250757646, 3746.2882052409955, 5145.305383773292, 5384.461553844584, 5390.838274851604, 5400.594955378441, 5415.160650099241, 5169.7673604687125, 5172.689638621695, 5186.273921650896, 5186.740662966912, 5199.66202196856, 5182.538294310323, 5202.271681964452, 5212.348456442945, 5233.502817232356, 5245.580353571781, 4994.925076123934, 5114.795408183631, 5132.692038477703, 5153.948460515347, 5157.303763991963, 5061.367329083864, 5181.134791475141, 5204.0, 5214.895702085862, 5257.4216836147225, 5061.215511595708, 5087.796488140433, 5112.565431938178, 5116.590672746246, 5122.923156152735], "value": 3873.111819454192, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.4707866010542, 651.2250421997823, 720.0639169080195, 735.1839458201397, 765.5980610179655, 12884.613461596155, 13367.06430549862, 13375.197488150718, 13421.060525763212, 13570.864291357084, 12953.805692914613, 13131.934340328286, 13188.14277071992, 13227.470901163942, 13288.867111328884, 786.6027656033694, 819.2012787532168, 821.9465734727254, 826.3348004856089, 827.0943317067802, 820.3396266005863, 822.8930239068943, 824.5011767880436, 826.1985873702529, 826.2935190412201, 849.9957500212521, 853.036069241756, 856.9957150214271, 857.2199298638241, 857.7941294089436, 847.9872801907976, 848.499385362636, 849.6473963305283, 850.0267194062794, 851.2296371783546, 627.7834147219202, 628.2272804450552, 628.9748410063592, 629.0187307799802, 629.3674856768964, 12029.097817663624, 12038.939805301005, 12184.329861857594, 12225.572104976283, 12768.61694149177, 10481.371117732884, 10527.420991845445, 10627.574897004111, 10716.35701857891, 10981.39602321872, 9344.439333640003, 9346.15884570392, 9587.616495340179, 9654.951725241399, 9698.36960597559, 3163.2724473371254, 3180.2685382361956, 3188.681131886816, 3195.7762956593047, 3210.341879914612, 60309.6984515079, 61033.694831526, 62197.68901155511, 62968.68515657393, 63297.0, 8131.9593402032615, 8137.349012079019, 8174.468659537111, 8221.958890205511, 8230.62962166704, 17139.14304284781, 17235.31058757661, 17265.741013884803, 17276.13619319029, 17344.306227751, 6698.0, 6724.554220842445, 6793.06002518538, 6797.422219111332, 7011.824704382329, 3429.228423604719, 3522.295540891832, 3540.451230059345, 3546.7517273791104, 3592.6946209571956, 2784.4987902177804, 2861.8998335058172, 2867.168521128891, 2908.578256152888, 3036.8481575921114, 493.67417504446894, 518.4452635679862, 524.0959345129621, 539.5575627985093, 546.1670951798538, 626.4549841637804, 626.7211091064523, 638.9073584330246, 645.5932762359683, 655.7540922154192, 7910.604469776488, 7986.361091112697, 8168.550729709804, 8248.876266856001, 8655.783605409915, 651.6567080409116, 667.4160109903834, 672.0951273103285, 673.8214373191108, 679.242644451443, 3881.146147847469, 3920.5702647657863, 4092.0, 4124.876253712393, 4236.576342365739, 63794.0, 66703.66648166729, 67980.6600966992, 69167.65416172887, 69438.3056169442, 57059.71470142623, 58015.0, 58202.0, 59993.70003149956, 60064.399356006754, 56516.0, 56635.15047274294, 57230.42769572251, 57499.712501438065, 57606.7119664399, 7704.499207551491, 8222.0, 8499.83000340002, 8769.736907892773, 8783.429077109968, 33742.66257337395, 34491.31017379688, 35235.29529409449, 36121.27757444889, 36514.0, 46293.768531157126, 46499.76750116228, 46882.0, 47287.52712472831, 47332.2900156491, 10432.530536125741, 10457.84313235287, 10534.57861685524, 10695.786084278427, 10827.187960902806, 12869.549565765154, 12922.524381653577, 12965.286909220084, 13014.674633134247, 13891.930540347234, 12386.5664701735, 12578.622641320775, 12590.748185036431, 12718.618441446772, 12780.744385112432, 12610.0, 12704.74590508203, 13129.29718294417, 13272.80090798658, 13442.462301508222, 12073.69815754578, 12131.0, 12285.0, 12489.125761196992, 12951.352432378155, 9910.504474776088, 9934.652287169914, 9973.30186886911, 10268.281220314806, 10421.478926053514, 9397.577109029973, 9936.105750482491, 10018.899811001796, 10068.949655251678, 10070.546825392728], "value": 6302.484135405963, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 125.0, 172.0, 130.0, 125.0, 126.0, 126.0, 153.0, 136.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 174.0, 165.0, 162.0, 162.0, 165.0, 163.0, 165.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 103.0, 78.0, 77.0, 75.0, 77.0, 102.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 85.0, 86.0, 84.0, 97.0, 85.0, 85.0, 101.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 118.0, 121.0, 118.0, 118.0, 119.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 150.0, 152.0, 151.0, 150.0, 151.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 98.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 70.0, 68.0, 69.0, 70.0, 68.0, 68.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 84.0, 84.0, 85.0, 84.0, 84.0, 90.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 146.0, 141.0, 151.0, 137.0, 137.0, 145.0, 136.0, 191.0, 150.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 181.0, 180.0, 175.0, 177.0, 177.0, 177.0, 180.0, 187.0, 181.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 69.0, 69.0, 69.0, 74.0, 71.0, 70.0, 72.0], "value": 70.6, "unit": "score"}]}]} 15:48:43 INFO - Return code: 0 15:48:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:48:44 ERROR - # TBPL SUCCESS # 15:48:44 INFO - Running post-action listener: _resource_record_post_action 15:48:44 INFO - [mozharness: 2017-01-06 23:48:44.019896Z] Finished run-tests step (success) 15:48:44 INFO - Running post-run listener: _resource_record_post_run 15:48:44 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384065536; Read time: 8; Write time: 247704 15:48:44 INFO - TinderboxPrint: CPU usage
13.5% 15:48:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:48:44 INFO - TinderboxPrint: I/O write bytes / time
384,065,536 / 247,704 15:48:44 INFO - TinderboxPrint: CPU idle
8,277.2 (86.5%) 15:48:44 INFO - TinderboxPrint: CPU user
1,233.9 (12.9%) 15:48:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:48:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99258368; Read time: 0; Write time: 57828 15:48:44 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 284807168; Read time: 0; Write time: 189876 15:48:44 INFO - Running post-run listener: _upload_blobber_files 15:48:44 INFO - Blob upload gear active. 15:48:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:48:44 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 15:48:44 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'] 15:48:44 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 15:48:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:45 INFO - (blobuploader) - INFO - Done attempting. 15:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:49 INFO - (blobuploader) - INFO - Done attempting. 15:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:49 INFO - (blobuploader) - INFO - Done attempting. 15:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:48:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:51 INFO - (blobuploader) - INFO - Done attempting. 15:48:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:48:51 INFO - Return code: 0 15:48:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:48:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:48:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba78e0efd4afdfc830467a948f1097723f2c6d37222b8f369dfb853e9862ec4db59a0d9dbfb5be7dcba3b11a3b12ffd8293b06c51448e90bf3cd994e95417241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dd8487281e2a9e17bfaa3e478841fbf782b6e88afea2c23662fdd3defedd23005f7db226e90950366946a263ba2d65eed35dea4c801f756425cc266e2c260f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5993ce69ab0d84f9f807d2bb6229e3ff818b0687912a0674eee90ce36ba442da4800a7063fbe2b2dc44c9714bbd9f062e73aa050eaeada0bcf513180877b724e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d06e9bd4b5a64c1e2e5dcb1aa662447b00791c083c9c17ff9ec04248cbcd357ed7c452bffccea20a327d26e16295c4eaf72958ddfa79d13d7f3b74acb77d85f7"} 15:48:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:48:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:48:51 INFO - Contents: 15:48:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba78e0efd4afdfc830467a948f1097723f2c6d37222b8f369dfb853e9862ec4db59a0d9dbfb5be7dcba3b11a3b12ffd8293b06c51448e90bf3cd994e95417241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dd8487281e2a9e17bfaa3e478841fbf782b6e88afea2c23662fdd3defedd23005f7db226e90950366946a263ba2d65eed35dea4c801f756425cc266e2c260f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5993ce69ab0d84f9f807d2bb6229e3ff818b0687912a0674eee90ce36ba442da4800a7063fbe2b2dc44c9714bbd9f062e73aa050eaeada0bcf513180877b724e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d06e9bd4b5a64c1e2e5dcb1aa662447b00791c083c9c17ff9ec04248cbcd357ed7c452bffccea20a327d26e16295c4eaf72958ddfa79d13d7f3b74acb77d85f7"} 15:48:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:48:51 INFO - Copying logs to upload dir... 15:48:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:48:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.701744 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-06 15:48:50.866361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 15:48:50.869835) ========= 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=ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba78e0efd4afdfc830467a948f1097723f2c6d37222b8f369dfb853e9862ec4db59a0d9dbfb5be7dcba3b11a3b12ffd8293b06c51448e90bf3cd994e95417241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dd8487281e2a9e17bfaa3e478841fbf782b6e88afea2c23662fdd3defedd23005f7db226e90950366946a263ba2d65eed35dea4c801f756425cc266e2c260f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5993ce69ab0d84f9f807d2bb6229e3ff818b0687912a0674eee90ce36ba442da4800a7063fbe2b2dc44c9714bbd9f062e73aa050eaeada0bcf513180877b724e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d06e9bd4b5a64c1e2e5dcb1aa662447b00791c083c9c17ff9ec04248cbcd357ed7c452bffccea20a327d26e16295c4eaf72958ddfa79d13d7f3b74acb77d85f7"} build_url:https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/KQ_C3sZoRS20IMXedouOyA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba78e0efd4afdfc830467a948f1097723f2c6d37222b8f369dfb853e9862ec4db59a0d9dbfb5be7dcba3b11a3b12ffd8293b06c51448e90bf3cd994e95417241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dd8487281e2a9e17bfaa3e478841fbf782b6e88afea2c23662fdd3defedd23005f7db226e90950366946a263ba2d65eed35dea4c801f756425cc266e2c260f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5993ce69ab0d84f9f807d2bb6229e3ff818b0687912a0674eee90ce36ba442da4800a7063fbe2b2dc44c9714bbd9f062e73aa050eaeada0bcf513180877b724e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d06e9bd4b5a64c1e2e5dcb1aa662447b00791c083c9c17ff9ec04248cbcd357ed7c452bffccea20a327d26e16295c4eaf72958ddfa79d13d7f3b74acb77d85f7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 15:48:50.894663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:48:50.894955) ========= 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=ed14279e38b05397cf4aa391000001a4-1483745285.75611-899264797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004803 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:48:50.979516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 15:48:50.979824) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 15:48:50.980124) ========= ========= Total master_lag: 0.16 =========