builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1486353531.08 results: success (0) revision: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.076239) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.076714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.076995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.093053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.093346) ========= 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-1486353532.415659-605005268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-05 19:58:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-02-05 19:58:53 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094436 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.201372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.201729) ========= 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-1486353532.415659-605005268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.251567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.251918) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 --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-1486353532.415659-605005268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-05 19:58:53,290 truncating revision to first 12 chars 2017-02-05 19:58:53,290 Setting DEBUG logging. 2017-02-05 19:58:53,290 attempt 1/10 2017-02-05 19:58:53,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c3d208c04d8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 19:58:53,555 unpacking tar archive at: mozilla-aurora-c3d208c04d8b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587392 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.852522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.852914) ========= script_repo_revision: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.853397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.854102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:58:51.866263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-05 19:58:51.867035) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:53 INFO - MultiFileLogger online at 20170205 19:58:53 in /builds/slave/test 19:58:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:58:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:58:54 INFO - {'append_to_log': False, 19:58:54 INFO - 'base_work_dir': '/builds/slave/test', 19:58:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:58:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:58:54 INFO - 'branch': 'Mozilla-Aurora', 19:58:54 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:54 INFO - 'config_files': ('talos/linux_config.py',), 19:58:54 INFO - 'default_actions': ('clobber', 19:58:54 INFO - 'read-buildbot-config', 19:58:54 INFO - 'download-and-extract', 19:58:54 INFO - 'populate-webroot', 19:58:54 INFO - 'create-virtualenv', 19:58:54 INFO - 'install', 19:58:54 INFO - 'run-tests'), 19:58:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:54 INFO - 'download_minidump_stackwalk': True, 19:58:54 INFO - 'download_symbols': 'ondemand', 19:58:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:54 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:54 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:54 INFO - 'installer_path': 'installer.exe', 19:58:54 INFO - 'log_level': 'info', 19:58:54 INFO - 'log_name': 'talos', 19:58:54 INFO - 'log_to_console': True, 19:58:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:54 INFO - 'opt_config_files': (), 19:58:54 INFO - 'pip_index': False, 19:58:54 INFO - 'sps_profile': False, 19:58:54 INFO - 'sps_profile_interval': 0, 19:58:54 INFO - 'suite': 'dromaeojs-e10s', 19:58:54 INFO - 'system_bits': '32', 19:58:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:54 INFO - 'title': 'talos-linux64-ix-035', 19:58:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:54 INFO - 'use_talos_json': True, 19:58:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:58:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:54 INFO - 'work_dir': 'build'} 19:58:54 INFO - [mozharness: 2017-02-06 03:58:54.004714Z] Running clobber step. 19:58:54 INFO - Running pre-action listener: _resource_record_pre_action 19:58:54 INFO - Running main action method: clobber 19:58:54 INFO - rmtree: /builds/slave/test/build 19:58:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:58:54 INFO - Running post-action listener: _resource_record_post_action 19:58:54 INFO - [mozharness: 2017-02-06 03:58:54.464842Z] Finished clobber step (success) 19:58:54 INFO - [mozharness: 2017-02-06 03:58:54.464944Z] Running read-buildbot-config step. 19:58:54 INFO - Running pre-action listener: _resource_record_pre_action 19:58:54 INFO - Running main action method: read_buildbot_config 19:58:54 INFO - Using buildbot properties: 19:58:54 INFO - { 19:58:54 INFO - "project": "", 19:58:54 INFO - "product": "firefox", 19:58:54 INFO - "who": "philringnalda@gmail.com", 19:58:54 INFO - "installer_path": "public/build/target.tar.bz2", 19:58:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:58:54 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 19:58:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:58:54 INFO - "stage_platform": "linux64-pgo", 19:58:54 INFO - "basedir": "/builds/slave/test", 19:58:54 INFO - "buildnumber": 848, 19:58:54 INFO - "platform": "ubuntu64_hw", 19:58:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:58:54 INFO - "slavebuilddir": "test", 19:58:54 INFO - "taskId": "WjCEYq7CR0ebmZ2-ISoxGg", 19:58:54 INFO - "branch": "mozilla-aurora", 19:58:54 INFO - "script_repo_revision": "production", 19:58:54 INFO - "revision": "c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349", 19:58:54 INFO - "slavename": "talos-linux64-ix-035", 19:58:54 INFO - "repo_path": "releases/mozilla-aurora" 19:58:54 INFO - } 19:58:54 INFO - Finding installer, test and symbols from parent task. 19:58:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WjCEYq7CR0ebmZ2-ISoxGg'}, attempt #1 19:58:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WjCEYq7CR0ebmZ2-ISoxGg'}, attempt #1 19:58:55 INFO - Task dependencies: M8kGUwdyS8uANgiefunbVQ 19:58:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ'}, attempt #1 19:58:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2 19:58:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/test_packages.json 19:58:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.crashreporter-symbols.zip 19:58:56 INFO - Running post-action listener: _resource_record_post_action 19:58:56 INFO - [mozharness: 2017-02-06 03:58:56.099407Z] Finished read-buildbot-config step (success) 19:58:56 INFO - [mozharness: 2017-02-06 03:58:56.099625Z] Running download-and-extract step. 19:58:56 INFO - Running pre-action listener: _resource_record_pre_action 19:58:56 INFO - Running main action method: download_and_extract 19:58:56 INFO - mkdir: /builds/slave/test/build/tests 19:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:56 INFO - trying https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.test_packages.json 19:58:56 INFO - Downloading https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:58:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:58:56 INFO - Downloaded 896 bytes. 19:58:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:58:56 INFO - Using the following test package requirements: 19:58:56 INFO - {u'common': [u'target.common.tests.zip'], 19:58:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:58:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:58:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:58:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:58:56 INFO - u'mozbase': [u'target.common.tests.zip'], 19:58:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:58:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:58:56 INFO - u'web-platform': [u'target.common.tests.zip', 19:58:56 INFO - u'target.web-platform.tests.zip'], 19:58:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:58:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.common.tests.zip 19:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.common.tests.zip into memory 19:58:57 INFO - Expected file size: 21854713 19:58:57 INFO - Obtained file size: 21854713 19:59:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:59:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.common.tests.zip 19:59:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:59:01 INFO - Fetch https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.common.tests.zip into memory 19:59:02 INFO - Expected file size: 21854713 19:59:02 INFO - Obtained file size: 21854713 19:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.talos.tests.zip 19:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.talos.tests.zip into memory 19:59:07 INFO - Expected file size: 14403485 19:59:07 INFO - Obtained file size: 14403485 19:59:07 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')]} 19:59:07 INFO - trying https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2 19:59:07 INFO - Downloading https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:59:09 INFO - Downloaded 66069460 bytes. 19:59:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2 19:59:09 INFO - mkdir: /builds/slave/test/properties 19:59:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:09 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:09 INFO - Contents: 19:59:09 INFO - build_url:https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2 19:59:09 INFO - Running post-action listener: _resource_record_post_action 19:59:09 INFO - Running post-action listener: set_extra_try_arguments 19:59:09 INFO - [mozharness: 2017-02-06 03:59:09.044886Z] Finished download-and-extract step (success) 19:59:09 INFO - [mozharness: 2017-02-06 03:59:09.044983Z] Running populate-webroot step. 19:59:09 INFO - Running pre-action listener: _resource_record_pre_action 19:59:09 INFO - Running main action method: populate_webroot 19:59:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:09 INFO - '--tppagecycles', 19:59:09 INFO - '7'], 19:59:09 INFO - 'tests': ['tsvgm']}}, 19:59:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:59:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:59:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:59:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:59:09 INFO - 'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:59:09 INFO - 'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['damp', 'tps']}, 19:59:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:59:09 INFO - 'tests': ['damp', 'tps']}, 19:59:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['dromaeo_dom']}, 19:59:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['basic_compositor_video']}, 19:59:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:59:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore', 19:59:09 INFO - 'tabpaint']}, 19:59:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore', 19:59:09 INFO - 'tabpaint']}, 19:59:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore', 19:59:09 INFO - 'tabpaint']}, 19:59:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore', 19:59:09 INFO - 'tabpaint']}, 19:59:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore', 19:59:09 INFO - 'tabpaint']}, 19:59:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore', 19:59:09 INFO - 'tabpaint']}, 19:59:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['tsvgx', 19:59:09 INFO - 'tsvgr_opacity', 19:59:09 INFO - 'tart', 19:59:09 INFO - 'tscrollx', 19:59:09 INFO - 'cart', 19:59:09 INFO - 'tsvg_static']}, 19:59:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:59:09 INFO - 'tsvgr_opacity', 19:59:09 INFO - 'tart', 19:59:09 INFO - 'tscrollx', 19:59:09 INFO - 'cart', 19:59:09 INFO - 'tsvg_static']}, 19:59:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:59:09 INFO - 'talos_options': ['--disable-e10s'], 19:59:09 INFO - 'tests': ['tp5o']}, 19:59:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:59:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:59:09 INFO - 'talos_options': ['--disable-e10s', 19:59:09 INFO - '--xperf_path', 19:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:09 INFO - 'tests': ['tp5n']}, 19:59:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:59:09 INFO - 'talos_options': ['--xperf_path', 19:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:09 INFO - 'tests': ['tp5n']}}, 19:59:09 INFO - 'talos.zip': {'path': '', 19:59:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:09 INFO - Running post-action listener: _resource_record_post_action 19:59:09 INFO - [mozharness: 2017-02-06 03:59:09.058125Z] Finished populate-webroot step (success) 19:59:09 INFO - [mozharness: 2017-02-06 03:59:09.058216Z] Running create-virtualenv step. 19:59:09 INFO - Running pre-action listener: _resource_record_pre_action 19:59:09 INFO - Running main action method: create_virtualenv 19:59:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:09 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 19:59:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:09 INFO - Using real prefix '/usr' 19:59:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:11 INFO - Installing pip.................done. 19:59:11 INFO - Return code: 0 19:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:59:11 INFO - Reading from file tmpfile_stdout 19:59:11 INFO - Output received: 19:59:11 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) 19:59:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:11 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')]} 19:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:11 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')]} 19:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:11 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:11 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 19:59:11 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 19:59:11 INFO - Using env: {'DISPLAY': ':0', 19:59:11 INFO - 'HOME': '/home/cltbld', 19:59:11 INFO - 'LANG': 'en_US.UTF-8', 19:59:11 INFO - 'LANGUAGE': 'en_US:en', 19:59:11 INFO - 'LOGNAME': 'cltbld', 19:59:11 INFO - 'MAIL': '/var/mail/cltbld', 19:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:11 INFO - 'MOZ_NO_REMOTE': '1', 19:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:11 INFO - 'NO_EM_RESTART': '1', 19:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:11 INFO - 'PWD': '/builds/slave/test', 19:59:11 INFO - 'SHELL': '/bin/bash', 19:59:11 INFO - 'SHLVL': '1', 19:59:11 INFO - 'TERM': 'linux', 19:59:11 INFO - 'TMOUT': '86400', 19:59:11 INFO - 'USER': 'cltbld', 19:59:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:11 INFO - '_': '/tools/buildbot/bin/python'} 19:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:12 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 19:59:12 INFO - Cleaning up... 19:59:12 INFO - Return code: 0 19:59:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:59:12 INFO - Using env: {'DISPLAY': ':0', 19:59:12 INFO - 'HOME': '/home/cltbld', 19:59:12 INFO - 'LANG': 'en_US.UTF-8', 19:59:12 INFO - 'LANGUAGE': 'en_US:en', 19:59:12 INFO - 'LOGNAME': 'cltbld', 19:59:12 INFO - 'MAIL': '/var/mail/cltbld', 19:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:12 INFO - 'MOZ_NO_REMOTE': '1', 19:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:12 INFO - 'NO_EM_RESTART': '1', 19:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:12 INFO - 'PWD': '/builds/slave/test', 19:59:12 INFO - 'SHELL': '/bin/bash', 19:59:12 INFO - 'SHLVL': '1', 19:59:12 INFO - 'TERM': 'linux', 19:59:12 INFO - 'TMOUT': '86400', 19:59:12 INFO - 'USER': 'cltbld', 19:59:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:12 INFO - '_': '/tools/buildbot/bin/python'} 19:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:12 INFO - Downloading/unpacking psutil>=3.1.1 19:59:12 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 19:59:12 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 19:59:12 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 19:59:12 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 19:59:12 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 19:59:12 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 19:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:14 INFO - Installing collected packages: psutil 19:59:14 INFO - Running setup.py install for psutil 19:59:14 INFO - building 'psutil._psutil_linux' extension 19:59:14 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 19:59:14 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 19:59:14 INFO - building 'psutil._psutil_posix' extension 19:59:14 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 19:59:14 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 19:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:14 INFO - Successfully installed psutil 19:59:14 INFO - Cleaning up... 19:59:15 INFO - Return code: 0 19:59:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:59:15 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')]} 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 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')]} 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:15 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 19:59:15 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 19:59:15 INFO - Using env: {'DISPLAY': ':0', 19:59:15 INFO - 'HOME': '/home/cltbld', 19:59:15 INFO - 'LANG': 'en_US.UTF-8', 19:59:15 INFO - 'LANGUAGE': 'en_US:en', 19:59:15 INFO - 'LOGNAME': 'cltbld', 19:59:15 INFO - 'MAIL': '/var/mail/cltbld', 19:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:15 INFO - 'MOZ_NO_REMOTE': '1', 19:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:15 INFO - 'NO_EM_RESTART': '1', 19:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:15 INFO - 'PWD': '/builds/slave/test', 19:59:15 INFO - 'SHELL': '/bin/bash', 19:59:15 INFO - 'SHLVL': '1', 19:59:15 INFO - 'TERM': 'linux', 19:59:15 INFO - 'TMOUT': '86400', 19:59:15 INFO - 'USER': 'cltbld', 19:59:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:15 INFO - '_': '/tools/buildbot/bin/python'} 19:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:59:17 INFO - Installing collected packages: mozsystemmonitor 19:59:17 INFO - Running setup.py install for mozsystemmonitor 19:59:17 INFO - Successfully installed mozsystemmonitor 19:59:17 INFO - Cleaning up... 19:59:17 INFO - Return code: 0 19:59:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:59:17 INFO - Using env: {'DISPLAY': ':0', 19:59:17 INFO - 'HOME': '/home/cltbld', 19:59:17 INFO - 'LANG': 'en_US.UTF-8', 19:59:17 INFO - 'LANGUAGE': 'en_US:en', 19:59:17 INFO - 'LOGNAME': 'cltbld', 19:59:17 INFO - 'MAIL': '/var/mail/cltbld', 19:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:17 INFO - 'MOZ_NO_REMOTE': '1', 19:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:17 INFO - 'NO_EM_RESTART': '1', 19:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:17 INFO - 'PWD': '/builds/slave/test', 19:59:17 INFO - 'SHELL': '/bin/bash', 19:59:17 INFO - 'SHLVL': '1', 19:59:17 INFO - 'TERM': 'linux', 19:59:17 INFO - 'TMOUT': '86400', 19:59:17 INFO - 'USER': 'cltbld', 19:59:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:17 INFO - '_': '/tools/buildbot/bin/python'} 19:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:17 INFO - Downloading/unpacking jsonschema==2.5.1 19:59:17 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 19:59:17 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 19:59:17 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 19:59:17 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 19:59:17 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 19:59:17 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 19:59:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:59:19 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 19:59:19 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 19:59:19 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 19:59:19 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 19:59:19 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 19:59:19 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 19:59:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:19 INFO - warning: no files found matching '*.txt' 19:59:19 INFO - no previously-included directories found matching 'build' 19:59:19 INFO - no previously-included directories found matching 'dist' 19:59:19 INFO - no previously-included directories found matching '.git*' 19:59:19 INFO - Installing collected packages: jsonschema, functools32 19:59:19 INFO - Running setup.py install for functools32 19:59:20 INFO - warning: no files found matching '*.txt' 19:59:20 INFO - no previously-included directories found matching 'build' 19:59:20 INFO - no previously-included directories found matching 'dist' 19:59:20 INFO - no previously-included directories found matching '.git*' 19:59:20 INFO - Successfully installed jsonschema functools32 19:59:20 INFO - Cleaning up... 19:59:20 INFO - Return code: 0 19:59:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:20 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:20 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 19:59:20 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 19:59:20 INFO - Using env: {'DISPLAY': ':0', 19:59:20 INFO - 'HOME': '/home/cltbld', 19:59:20 INFO - 'LANG': 'en_US.UTF-8', 19:59:20 INFO - 'LANGUAGE': 'en_US:en', 19:59:20 INFO - 'LOGNAME': 'cltbld', 19:59:20 INFO - 'MAIL': '/var/mail/cltbld', 19:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:20 INFO - 'MOZ_NO_REMOTE': '1', 19:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:20 INFO - 'NO_EM_RESTART': '1', 19:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:20 INFO - 'PWD': '/builds/slave/test', 19:59:20 INFO - 'SHELL': '/bin/bash', 19:59:20 INFO - 'SHLVL': '1', 19:59:20 INFO - 'TERM': 'linux', 19:59:20 INFO - 'TMOUT': '86400', 19:59:20 INFO - 'USER': 'cltbld', 19:59:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:20 INFO - '_': '/tools/buildbot/bin/python'} 19:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:59:20 INFO - Cleaning up... 19:59:20 INFO - Return code: 0 19:59:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:20 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:20 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 19:59:20 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 19:59:20 INFO - Using env: {'DISPLAY': ':0', 19:59:20 INFO - 'HOME': '/home/cltbld', 19:59:20 INFO - 'LANG': 'en_US.UTF-8', 19:59:20 INFO - 'LANGUAGE': 'en_US:en', 19:59:20 INFO - 'LOGNAME': 'cltbld', 19:59:20 INFO - 'MAIL': '/var/mail/cltbld', 19:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:20 INFO - 'MOZ_NO_REMOTE': '1', 19:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:20 INFO - 'NO_EM_RESTART': '1', 19:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:20 INFO - 'PWD': '/builds/slave/test', 19:59:20 INFO - 'SHELL': '/bin/bash', 19:59:20 INFO - 'SHLVL': '1', 19:59:20 INFO - 'TERM': 'linux', 19:59:20 INFO - 'TMOUT': '86400', 19:59:20 INFO - 'USER': 'cltbld', 19:59:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:20 INFO - '_': '/tools/buildbot/bin/python'} 19:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:20 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:20 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 19:59:20 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 19:59:20 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 19:59:20 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 19:59:20 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 19:59:20 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 19:59:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:59:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:23 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 19:59:23 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 19:59:23 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 19:59:23 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 19:59:23 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 19:59:23 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 19:59:23 INFO - Downloading docopt-0.6.1.tar.gz 19:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:23 INFO - Running setup.py install for blobuploader 19:59:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:59:23 INFO - Running setup.py install for requests 19:59:23 INFO - Running setup.py install for docopt 19:59:23 INFO - Successfully installed blobuploader requests docopt 19:59:23 INFO - Cleaning up... 19:59:24 INFO - Return code: 0 19:59:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:24 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:24 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 19:59:24 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 19:59:24 INFO - Using env: {'DISPLAY': ':0', 19:59:24 INFO - 'HOME': '/home/cltbld', 19:59:24 INFO - 'LANG': 'en_US.UTF-8', 19:59:24 INFO - 'LANGUAGE': 'en_US:en', 19:59:24 INFO - 'LOGNAME': 'cltbld', 19:59:24 INFO - 'MAIL': '/var/mail/cltbld', 19:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:24 INFO - 'MOZ_NO_REMOTE': '1', 19:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:24 INFO - 'NO_EM_RESTART': '1', 19:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:24 INFO - 'PWD': '/builds/slave/test', 19:59:24 INFO - 'SHELL': '/bin/bash', 19:59:24 INFO - 'SHLVL': '1', 19:59:24 INFO - 'TERM': 'linux', 19:59:24 INFO - 'TMOUT': '86400', 19:59:24 INFO - 'USER': 'cltbld', 19:59:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:24 INFO - '_': '/tools/buildbot/bin/python'} 19:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:24 INFO - Running setup.py (path:/tmp/pip-ePnuAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:24 INFO - Running setup.py (path:/tmp/pip-l5d8JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:24 INFO - Running setup.py (path:/tmp/pip-Ex7Dlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:24 INFO - Running setup.py (path:/tmp/pip-o0KM9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:24 INFO - Running setup.py (path:/tmp/pip-3Rz3kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:24 INFO - Running setup.py (path:/tmp/pip-g6dyp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:24 INFO - Running setup.py (path:/tmp/pip-1fYC29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:24 INFO - Running setup.py (path:/tmp/pip-_4g9zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:24 INFO - Running setup.py (path:/tmp/pip-OjW2hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:24 INFO - Running setup.py (path:/tmp/pip-FFckhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:24 INFO - Running setup.py (path:/tmp/pip-q1jUL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:25 INFO - Running setup.py (path:/tmp/pip-fiJ0KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:25 INFO - Running setup.py (path:/tmp/pip-DAsEfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:25 INFO - Running setup.py (path:/tmp/pip-ts95Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:25 INFO - Running setup.py (path:/tmp/pip-3ypy0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:25 INFO - Running setup.py (path:/tmp/pip-gUuBA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:25 INFO - Running setup.py (path:/tmp/pip-oJgQNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:25 INFO - Running setup.py install for manifestparser 19:59:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:59:25 INFO - Running setup.py install for mozcrash 19:59:25 INFO - Running setup.py install for mozdebug 19:59:25 INFO - Running setup.py install for mozdevice 19:59:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:59:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:59:25 INFO - Running setup.py install for mozfile 19:59:25 INFO - Running setup.py install for mozhttpd 19:59:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Running setup.py install for mozinfo 19:59:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Running setup.py install for mozInstall 19:59:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Running setup.py install for mozleak 19:59:26 INFO - Running setup.py install for mozlog 19:59:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Running setup.py install for moznetwork 19:59:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Running setup.py install for mozprocess 19:59:26 INFO - Running setup.py install for mozprofile 19:59:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Running setup.py install for mozrunner 19:59:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:59:26 INFO - Running setup.py install for mozscreenshot 19:59:27 INFO - Running setup.py install for moztest 19:59:27 INFO - Running setup.py install for mozversion 19:59:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:59:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:27 INFO - Cleaning up... 19:59:27 INFO - Return code: 0 19:59:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:27 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:27 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 19:59:27 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 19:59:27 INFO - Using env: {'DISPLAY': ':0', 19:59:27 INFO - 'HOME': '/home/cltbld', 19:59:27 INFO - 'LANG': 'en_US.UTF-8', 19:59:27 INFO - 'LANGUAGE': 'en_US:en', 19:59:27 INFO - 'LOGNAME': 'cltbld', 19:59:27 INFO - 'MAIL': '/var/mail/cltbld', 19:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:27 INFO - 'MOZ_NO_REMOTE': '1', 19:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:27 INFO - 'NO_EM_RESTART': '1', 19:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:27 INFO - 'PWD': '/builds/slave/test', 19:59:27 INFO - 'SHELL': '/bin/bash', 19:59:27 INFO - 'SHLVL': '1', 19:59:27 INFO - 'TERM': 'linux', 19:59:27 INFO - 'TMOUT': '86400', 19:59:27 INFO - 'USER': 'cltbld', 19:59:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:27 INFO - '_': '/tools/buildbot/bin/python'} 19:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:27 INFO - Running setup.py (path:/tmp/pip-Av_D1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:27 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)) 19:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:27 INFO - Running setup.py (path:/tmp/pip-o2i_lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:27 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)) 19:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:27 INFO - Running setup.py (path:/tmp/pip-kONolo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:27 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)) 19:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:27 INFO - Running setup.py (path:/tmp/pip-v8OVAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:27 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)) 19:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:27 INFO - Running setup.py (path:/tmp/pip-tKLyqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:27 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)) 19:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:27 INFO - Running setup.py (path:/tmp/pip-7bnmn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:27 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)) 19:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:27 INFO - Running setup.py (path:/tmp/pip-J5kSE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:28 INFO - Running setup.py (path:/tmp/pip-BBW4DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:28 INFO - Running setup.py (path:/tmp/pip-fbOSOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:28 INFO - Running setup.py (path:/tmp/pip-2N4jo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:28 INFO - Running setup.py (path:/tmp/pip-4KBbvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:28 INFO - Running setup.py (path:/tmp/pip-ys8j_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:28 INFO - Running setup.py (path:/tmp/pip-kJUBl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:28 INFO - Running setup.py (path:/tmp/pip-zowzyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:28 INFO - Running setup.py (path:/tmp/pip-a6YmJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:28 INFO - Running setup.py (path:/tmp/pip-HccQO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:28 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)) 19:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:28 INFO - Running setup.py (path:/tmp/pip-ktugOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:28 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)) 19:59:28 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)) 19:59:28 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)) 19:59:28 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)) 19:59:28 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)) 19:59:28 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)) 19:59:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:28 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 19:59:28 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 19:59:28 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 19:59:28 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 19:59:28 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 19:59:28 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 19:59:30 INFO - Downloading blessings-1.6.tar.gz 19:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:30 INFO - Installing collected packages: blessings 19:59:30 INFO - Running setup.py install for blessings 19:59:30 INFO - Successfully installed blessings 19:59:30 INFO - Cleaning up... 19:59:30 INFO - Return code: 0 19:59:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:31 INFO - Reading from file tmpfile_stdout 19:59:31 INFO - Current package versions: 19:59:31 INFO - argparse == 1.2.1 19:59:31 INFO - blessings == 1.6 19:59:31 INFO - blobuploader == 1.2.4 19:59:31 INFO - docopt == 0.6.1 19:59:31 INFO - functools32 == 3.2.3-2 19:59:31 INFO - jsonschema == 2.5.1 19:59:31 INFO - manifestparser == 1.1 19:59:31 INFO - mozInstall == 1.12 19:59:31 INFO - mozcrash == 1.0 19:59:31 INFO - mozdebug == 0.1 19:59:31 INFO - mozdevice == 0.49 19:59:31 INFO - mozfile == 1.2 19:59:31 INFO - mozhttpd == 0.7 19:59:31 INFO - mozinfo == 0.9 19:59:31 INFO - mozleak == 0.1 19:59:31 INFO - mozlog == 3.4 19:59:31 INFO - moznetwork == 0.27 19:59:31 INFO - mozprocess == 0.24 19:59:31 INFO - mozprofile == 0.28 19:59:31 INFO - mozrunner == 6.13 19:59:31 INFO - mozscreenshot == 0.1 19:59:31 INFO - mozsystemmonitor == 0.3 19:59:31 INFO - moztest == 0.8 19:59:31 INFO - mozversion == 1.4 19:59:31 INFO - psutil == 3.1.1 19:59:31 INFO - requests == 1.2.3 19:59:31 INFO - wsgiref == 0.1.2 19:59:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:31 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')]} 19:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:31 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')]} 19:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:31 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:31 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 19:59:31 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 19:59:31 INFO - Using env: {'DISPLAY': ':0', 19:59:31 INFO - 'HOME': '/home/cltbld', 19:59:31 INFO - 'LANG': 'en_US.UTF-8', 19:59:31 INFO - 'LANGUAGE': 'en_US:en', 19:59:31 INFO - 'LOGNAME': 'cltbld', 19:59:31 INFO - 'MAIL': '/var/mail/cltbld', 19:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:31 INFO - 'MOZ_NO_REMOTE': '1', 19:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:31 INFO - 'NO_EM_RESTART': '1', 19:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:31 INFO - 'PWD': '/builds/slave/test', 19:59:31 INFO - 'SHELL': '/bin/bash', 19:59:31 INFO - 'SHLVL': '1', 19:59:31 INFO - 'TERM': 'linux', 19:59:31 INFO - 'TMOUT': '86400', 19:59:31 INFO - 'USER': 'cltbld', 19:59:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:31 INFO - '_': '/tools/buildbot/bin/python'} 19:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 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)) 19:59:31 INFO - Cleaning up... 19:59:31 INFO - Return code: 0 19:59:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:59:31 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')]} 19:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:31 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')]} 19:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:31 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 0xfce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1340480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, '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-1486353532.415659-605005268', '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 19:59:31 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 19:59:31 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 19:59:31 INFO - Using env: {'DISPLAY': ':0', 19:59:31 INFO - 'HOME': '/home/cltbld', 19:59:31 INFO - 'LANG': 'en_US.UTF-8', 19:59:31 INFO - 'LANGUAGE': 'en_US:en', 19:59:31 INFO - 'LOGNAME': 'cltbld', 19:59:31 INFO - 'MAIL': '/var/mail/cltbld', 19:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:31 INFO - 'MOZ_NO_REMOTE': '1', 19:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:31 INFO - 'NO_EM_RESTART': '1', 19:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:31 INFO - 'PWD': '/builds/slave/test', 19:59:31 INFO - 'SHELL': '/bin/bash', 19:59:31 INFO - 'SHLVL': '1', 19:59:31 INFO - 'TERM': 'linux', 19:59:31 INFO - 'TMOUT': '86400', 19:59:31 INFO - 'USER': 'cltbld', 19:59:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:31 INFO - '_': '/tools/buildbot/bin/python'} 19:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:59:31 INFO - Cleaning up... 19:59:31 INFO - Return code: 0 19:59:31 INFO - Running post-action listener: _resource_record_post_action 19:59:31 INFO - Running post-action listener: _start_resource_monitoring 19:59:31 INFO - Starting resource monitoring. 19:59:31 INFO - [mozharness: 2017-02-06 03:59:31.678573Z] Finished create-virtualenv step (success) 19:59:31 INFO - [mozharness: 2017-02-06 03:59:31.679065Z] Running install step. 19:59:31 INFO - Running pre-action listener: _resource_record_pre_action 19:59:31 INFO - Running main action method: install 19:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:31 INFO - Reading from file tmpfile_stdout 19:59:31 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:59:31 INFO - Reading from file tmpfile_stdout 19:59:31 INFO - Output received: 19:59:31 INFO - Usage: mozinstall [options] installer 19:59:31 INFO - Options: 19:59:31 INFO - -h, --help show this help message and exit 19:59:31 INFO - -d DEST, --destination=DEST 19:59:31 INFO - Directory to install application into. [default: 19:59:31 INFO - "/builds/slave/test"] 19:59:31 INFO - --app=APP Application being installed. [default: firefox] 19:59:31 INFO - mkdir: /builds/slave/test/build/application 19:59:31 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'] 19:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:59:48 INFO - Reading from file tmpfile_stdout 19:59:48 INFO - Output received: 19:59:48 INFO - /builds/slave/test/build/application/firefox/firefox 19:59:48 INFO - Running post-action listener: _resource_record_post_action 19:59:48 INFO - [mozharness: 2017-02-06 03:59:48.394838Z] Finished install step (success) 19:59:48 INFO - [mozharness: 2017-02-06 03:59:48.395114Z] Running run-tests step. 19:59:48 INFO - Running pre-action listener: _resource_record_pre_action 19:59:48 INFO - Running main action method: run_tests 19:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:59:48 INFO - Python 2.7.3 19:59:48 INFO - Return code: 0 19:59:48 INFO - grabbing minidump binary from tooltool 19:59:48 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')]} 19:59:48 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 0x133d820>, '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 0x133e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133e9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:59:48 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 19:59:48 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 19:59:48 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 19:59:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:48 INFO - Return code: 0 19:59:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:59:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:59:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:59:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:59:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/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 19:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/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 19:59:48 INFO - Using env: {'DISPLAY': ':0', 19:59:48 INFO - 'HOME': '/home/cltbld', 19:59:48 INFO - 'LANG': 'en_US.UTF-8', 19:59:48 INFO - 'LANGUAGE': 'en_US:en', 19:59:48 INFO - 'LOGNAME': 'cltbld', 19:59:48 INFO - 'MAIL': '/var/mail/cltbld', 19:59:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:59:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:48 INFO - 'MOZ_NO_REMOTE': '1', 19:59:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:48 INFO - 'NO_EM_RESTART': '1', 19:59:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:48 INFO - 'PWD': '/builds/slave/test', 19:59:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:59:48 INFO - 'SHELL': '/bin/bash', 19:59:48 INFO - 'SHLVL': '1', 19:59:48 INFO - 'TERM': 'linux', 19:59:48 INFO - 'TMOUT': '86400', 19:59:48 INFO - 'USER': 'cltbld', 19:59:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1486353532.415659-605005268', 19:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:48 INFO - '_': '/tools/buildbot/bin/python'} 19:59:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/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 19:59:48 INFO - mozversion application_buildid: 20170206025433 19:59:48 INFO - mozversion application_changeset: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 19:59:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:59:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:48 INFO - mozversion application_name: Firefox 19:59:48 INFO - mozversion application_remotingname: firefox-dev 19:59:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:59:48 INFO - mozversion application_vendor: Mozilla 19:59:48 INFO - mozversion application_version: 53.0a2 19:59:48 INFO - mozversion platform_buildid: 20170206025433 19:59:48 INFO - mozversion platform_changeset: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 19:59:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:59:48 INFO - mozversion platform_version: 53.0a2 19:59:48 INFO - using testdate: 1486353588 19:59:48 INFO - actual date: 1486353588 19:59:48 INFO - starting webserver on 'localhost:56138' 19:59:48 INFO - SUITE-START | Running 2 tests 19:59:48 INFO - TEST-START | dromaeo_css 19:59:48 INFO - operating with platform_type : linux_ 19:59:48 INFO - Initialising browser for dromaeo_css test... 19:59:48 INFO - TEST-INFO | started process 7454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMMzXsu/profile http://localhost:56138/getInfo.html) 19:59:53 INFO - PROCESS | 7454 | __metrics Screen width/height:1600/1200 19:59:53 INFO - PROCESS | 7454 | colorDepth:24 19:59:53 INFO - PROCESS | 7454 | Browser inner width/height: 1024/697 19:59:53 INFO - PROCESS | 7454 | __metrics 19:59:53 INFO - PROCESS | 7454 | 1486353593671 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpMMzXsu/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpMMzXsu/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpMMzXsu/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpMMzXsu/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:59:53 ERROR - PROCESS | 7454 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 19:59:54 INFO - TEST-INFO | 7454: exit 0 19:59:54 INFO - Browser initialized. 19:59:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:54 INFO - TEST-INFO | started process 7583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMMzXsu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:06 INFO - PROCESS | 7583 | RSS: Main: 144703488 20:00:06 INFO - PROCESS | 7583 | 20:03:05 INFO - PROCESS | 7583 | Cycle 1(1): loaded http://localhost:56138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56138/tests/dromaeo/cssquery-ext.html) 20:03:07 INFO - PROCESS | 7583 | RSS: Main: 154607616 20:03:07 INFO - PROCESS | 7583 | 20:04:54 INFO - PROCESS | 7583 | ************************* 20:04:54 INFO - PROCESS | 7583 | A coding exception was thrown and uncaught in a Task. 20:04:54 INFO - PROCESS | 7583 | 20:04:54 ERROR - PROCESS | 7583 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:04:54 INFO - PROCESS | 7583 | Full stack: 20:04:54 INFO - PROCESS | 7583 | ************************* 20:06:09 INFO - PROCESS | 7583 | Cycle 1(1): loaded http://localhost:56138/tests/dromaeo/cssquery-ext.html (next: http://localhost:56138/tests/dromaeo/cssquery-jquery.html) 20:06:09 INFO - PROCESS | 7583 | RSS: Main: 149372928 20:06:09 INFO - PROCESS | 7583 | 20:09:11 INFO - PROCESS | 7583 | Cycle 1(1): loaded http://localhost:56138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56138/tests/dromaeo/cssquery-mootools.html) 20:09:12 INFO - PROCESS | 7583 | RSS: Main: 153063424 20:09:12 INFO - PROCESS | 7583 | 20:12:13 INFO - PROCESS | 7583 | Cycle 1(1): loaded http://localhost:56138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56138/tests/dromaeo/cssquery-prototype.html) 20:12:14 INFO - PROCESS | 7583 | RSS: Main: 149516288 20:12:14 INFO - PROCESS | 7583 | 20:15:16 INFO - PROCESS | 7583 | Cycle 1(1): loaded http://localhost:56138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56138/tests/dromaeo/cssquery-yui.html) 20:15:17 INFO - PROCESS | 7583 | RSS: Main: 155033600 20:15:17 INFO - PROCESS | 7583 | 20:18:19 INFO - PROCESS | 7583 | Cycle 1(1): loaded http://localhost:56138/tests/dromaeo/cssquery-yui.html (next: http://localhost:56138/tests/dromaeo/cssquery-dojo.html) 20:18:20 INFO - PROCESS | 7583 | RSS: Main: 153739264 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | __start_tp_report 20:18:20 INFO - PROCESS | 7583 | _x_x_mozilla_page_load 20:18:20 INFO - PROCESS | 7583 | _x_x_mozilla_page_load_details 20:18:20 INFO - PROCESS | 7583 | |i|pagename|runs| 20:18:20 INFO - PROCESS | 7583 | |0;dojo.html;3310.635830058694;3324.052644996176;3336.132605522565;3336.4494858348376;3354.580677415323;5524.585656075796;5581.972090139544;5581.972090139554;5593.888122237553;5596.916046259309;5575.358833734122;5621.212045880542;5624.15637654352;5637.9718101409535;5649.8587535311635;5109.565686916617;5121.2318152277085;5166.664166829144;5178.093833579127;5182.740862956856;5181.4300426953005;5188.8702782430555;5192.273081768555;5192.428832828386;5212.739363031852;5007.7496125193775;5014.222795466709;5182.507661772125;5185.948140518584;5199.68801871887;5045.545900868921;5088.287639730441;5110.514501122388;5152.742362881841;5196.29849970253;5111.361079865017;5141.76862041209;5167.638265321429;5173.715445650488;5173.9741301293625;5356.758945847408;5529.502344788948;5538.363088244863;5601.159826026129;5618.101103823409;5808;5867.794627188071;5891.587588868781;5911.793087241926;5919.378465261172;5994.520438364921;6009.939900601025;6025.457708806229;6037.577369584131;6051.757929682807;5617.241672374259;5634.042212823748;5634.521065709419;5637.774489020434;5640.435956404368;5860.736266868002;5884.11738239259;5983.760649574056;6081;6103.6032657877095;5802.622829516153;5861.062230043172;5879.794207202727;5882.852928676817;5898.085796701518;5951.315598706205;5954.225950626477;5956.285245770535;5959.135925290809;5971.552133589911;5782.88434231313;5805.477507024304;5866.73599688015;5890.734916928748;5912.674802885883;5913.142594323799;5980.700964951735;5981.581289309706;6031.366706495843;6067.059605761114;4571.1543364477675;4590.059037897223;4597.7241365518175;4605;4624.676272660881;3977.985613668554;4106.507219133663;4126.546079931205;4132.566080561498;4143.047099167208;5702.2301989231755;5721.170430287585;5745.339285982082;5757.193992841006;5870.354261031283;5970.641761494324;5996.16053752475;6022.759089636453;6026.789062382795;6027.849303767441;5603.831885043373;5608.803691870765;5852.970735146297;5855.736491857877;5857.736401861926;5063.11395505785;5073.797048118107;5075.365579302587;5099.69401835891;5104.515071068243;6321.494280457552;6329;6339.619622822645;6341.841453963688;6342.714577844008;5997.430244126801;6007.699615019144;6010.579259451796;6016.458518733335;6020.247469066367;6068.180795592715;6119;6141.670122563492;6159.938400615936;6210.192674952408;5840.853978650568;5896.616719913192;5897.292324921037;5909.52723782105;5923.940760592339;5926.496247818811;5996.430339117776;6010.2186715726675;6014.0678194879865;6016.548758843017;5666.2350582670815;5714.857128571819;5766.913496297643;5780.768769249183;5826.126081087701;5840.883182336414;5851.385604511635;5854.619449735754;5858.648481091148;5879.382664820132;5800.9419905800405;5811.070228763378;5822.70886455684;5825.3883342248455;5834.649921004753;5681.034224181982;5696.231008813757;5737.885242295048;5768.50967667753;5816.011278082651;5688.431156884279;5732.283464566929;5740.282464691913;5745.195672605755;5748.597598168088 20:18:20 INFO - PROCESS | 7583 | |1;ext.html;533.6168978684324;598.8532809461683;614.6496496996713;728.938040266577;734.3574372424129;43372.78313608431;44618.55381446185;48002.27996580045;48055.27917081242;48217.27674084883;48709.26936095962;49676.254856177184;49713.25430118551;49729;49754;9226.953865230682;10634.521446534924;11000;11044.226904116715;11318.547258109666;10956.452177391138;11054.502547385388;11056.502457389437;11057.281276717027;11066.059384952288;11122.666320010412;11164.665060048212;11170.944145279262;11182.44087795611;11192.608258710947;10997;11054.115670746321;11068.612598559052;11073.16951228653;11085.50115244816;10823.13414926804;10882.564697412094;10886.29239099456;10932.398718070503;10968.067714244218;42030.78984605088;42322.78838605818;42422;42523.36214956778;42816.57183428157;4370.147821174872;4405.31717583775;4423.093265880487;4510.413646225969;4531.818727250906;32056.519152212735;32145.83927080373;32551.348973020642;33138.3372332552;33804.83097584521;4362.345648152771;4475.351074094271;4491.6182124519455;4506.188886000518;4560.384348112995;370835;370887;371168;371731;373765;62974.37025629777;63309.36690633127;63311.36688633055;63939;63975.68012159909;60762.39237607656;60845.08732369018;60940;60961.39038609646;61102.38897611056;17533;17689.292428302982;18055.819441805677;18262;18279.086045697662;13323.267220302976;13717.725645487035;13761.31193440324;13768.586942391745;13782.517611883535;19493.75296142037;19704.01479925998;19795.703064454046;19902.90048549777;20061.197552098045;7362.484626076231;7424;7564.130125035581;7567.697292108364;7654.0447676218955;1018.6434747838198;1027.9023492768174;1034.8395998620226;1044.9320794148357;1048.6067724603274;33093.83453082719;33225.501617475755;33686.32627347439;33772.53607263251;33982.66017339844;1125.6510481750684;1188.0970462448602;1188.4830098907003;1190.36315571169;1197.6766273106211;17585.12074396275;17785.377511787025;17804.643907121786;17871;18026.729599056023;568707;569859;570800;572445;573642;68126.65936670285;68840.31159688439;68973;69139.65430172817;69334;1554.844515548436;1564.1788061268153;1565.3269094289565;1568.9372425103097;1572.481081243187;32251;32271.67728322687;32544.83727581347;32552.674473254963;33398.833005834815;43843;43992;44048.779756101016;44084.11831763411;44125.55874441343;438033;438376;439437;440933;441127;28636.28409289701;29229.123126306244;29275.41449171047;29414.264643384086;30670.233244169074;44063.11873762443;46157.30764038609;46646.76676616731;46771.53228467808;47112;39744.801275993435;39977;40056;40578.59421405866;41470;38868.61131388763;39329.41005884971;39590.802045989585;40071;40431.39352909767;40516.594834051284;40666.39000414937;49486.75256623694;49893.501064988886;49942.75028624979;43276.56723432725;46515;48791;49052.2642160375;49377.50622493729;37294.68888622528;37567.81216093902;37965.24069518649;38098.80950595229;38152.809235953646 20:18:20 INFO - PROCESS | 7583 | |2;jquery.html;435.43828461284943;436.99563004369946;440.7047278323523;442.9490608580013;453.21593642997635;21273.893630531864;21682.674759878613;22384;22436.66345004826;22467.662985055238;22368.328950131483;22768.65847012292;22896.427589310235;23147.884260578674;23214.419639509022;5840.795572154975;5871.089981052923;6059.727312270937;6068.57519973602;6081.817545473643;5871.559633027518;5927.644341339512;5974.850628734294;5989.85025374367;6001.519878409738;5799.797007104752;5956.583039187259;5970.253718285215;5979.671118088525;5992.191054207691;5978.9701051494685;5988.041913293874;6000.729967151467;6012.789552365646;6015.75936962521;5297.073012222884;5312.07038768214;5375;5386.91919621206;5435.266239057755;26004.86997565019;26020.8698956504;26162.73837261622;26175.083872064577;26465.206043818715;3227.1766451954572;3329.467285234351;3340.599128104643;3376.4428869236544;3406.131436483706;16090.83909160905;16138.193090345436;16302.429414970418;16499;16836.579085522837;2029.7056926745686;2033.30867505049;2041.3671761753756;2062.226665000625;2080.5422806982438;83000.58499707463;93209.5339523298;94065;95122.52438737832;96748.51625741896;11692.47383867728;11942.522299108112;12070.094742894318;12146;12471.5011399543;16635.251413686412;16765.24556394965;16774.161291935354;16785.748213776802;16798.748018779726;8936.151065648754;9043.954780226188;9191.402558833788;9201.539923003957;9226.169644732006;8739.388242823068;8898.777530561787;8944.597493112826;8998.370114091951;9088.772780680536;7527.623618819037;7593.924060759432;7674;7678.424118191158;7790;2153.407812851447;2171.2183613898983;2172.500324925276;2190.6494960806513;2232.676261942009;994.3785134291068;999.205631522941;1005.6731562242301;1009.5608410341525;1024.5235965276183;21248.78751212499;21459;21610.243641472473;21667.458313542287;21702.348929532138;994.6767300627181;1008.7528555503949;1009.7425156585024;1012.584840215508;1039.6309310194922;11934.582289619822;12016.279023258632;12121.515139394502;12219.144659873902;12242.938785306016;670816;670972;672568;711200;715364;93185;96117.51941240249;99417;99801.50099249458;100647;1157.3576664951033;1181.5037684172669;1201.2732296960387;1205.0600531585378;1215.8237055627062;18325.816741832412;18422.631547369245;18541.44375668732;18738.344157954405;18984.050797459797;43112.78443607887;46107.76946115248;46442.30336544887;50494.74752626213;51564.74217628888;63289;66270.66864665646;67923.66038169777;68561.31438685748;68834.65582672054;9811.411315321104;9876.950615246878;10061;10162.288639795439;10274.383536987805;11351.432428378383;11421.428928553372;15277;15310.693786123993;15477.84522154764;12718.491260349483;12747.298898560668;12780.552680656132;12828.935855320664;12924.547640832525;12254.264744115382;12363.443645035815;12405.193662411913;12669.873301266869;12801.871981280068;12376.876231237573;12836.294003829878;12840.678983025498;13074.738505229652;13124.409401577142;9971.700848974542;10113.848292275474;10122.374229251209;10220.182385409298;10371.533281002223;10579.788404231718;12423.751524969632;12592.181508201938;12633.3683315832;12871.613851584467 20:18:20 INFO - PROCESS | 7583 | |3;mootools.html;1481.925903704816;1520.680657062017;1538.246259332927;1546.4278217059682;1556.315221302626;8563.529005904687;8632.611532481038;8805.20753132218;9237.861432078516;9244.907550924498;8656.697015604455;8746.737597872074;8762.123787621234;8768.035516093225;8819.470831750099;2246.292417888364;2250.2911582851348;2279.5668822923676;2283.280766558537;2287.3023727763025;2357.6581395697613;2391.330427480308;2397.4845408237225;2401.0515846240723;2432.1609044879488;2362.7400985891536;2366.5740166769974;2389.6176611742126;2397.820163487737;2404.5791986402396;2308.988455057722;2320;2325.6976593042796;2344.355302291875;2347.6713260143592;2367.419982104378;2422.454947636785;2440.9389765255833;2443.7556244375596;2458.225658917453;9166.587503562356;9241.584128714225;9252.95373523128;9306.67426640071;9325.906740932573;5275.947240527584;5341.305630268079;5387.568994480433;5398.757055932492;5404.648697834628;3278.639349671534;3287.227501537137;3300.626221530864;3317.5023746437987;3422.5892892853017;1374.4845682868925;1398.258922770923;1416.744985902537;1417.4613646814144;1461.4373466215584;11853.46659400329;12604.55884044054;12619.432125554373;12651.177673451288;12732.108752387336;4434.290513517822;4552.245891235754;4565.863024109282;4603.194440972883;4608.124456353282;9914.55384507699;10039.09648131657;10039.598416063422;10061.19510439163;10070.44612546317;5416.729163541886;5421.2139239810795;5436.885438485101;5437.8368648940595;5442.183672449164;4836.419629644465;4969.155243608595;5004.3494345734825;5038.773255203525;5099.59203263738;3739.962600374016;3795.525559305087;3819.52255968004;3843.557990831034;3868.2456920900154;1129.4465711801158;1139.202558209257;1145.0953746540306;1148.0356500539588;1149.735560821016;956.3687965942445;988.41189492252;992.6277645882794;1001.5142655812072;1003.6637726361605;5540.335159780852;5621.775128994795;5695.373508914016;5699.2590963174525;5745.2818397700285;602.036741214054;610.4536439886277;615.7352338494491;617.1360095865734;631.8767840271103;3650;3716.888493345204;3807.7334586578672;3809.066778639251;3959.8812035638975;10878.129749620011;11206.103511719042;11256.549738010388;11282.323060616389;11293;10985.121190304757;11089.889101109047;11103.500342484607;11116.277441966246;11118.388488633203;8107.716229931924;8409.32725381968;8527.616257268437;8613.310935125175;8754.21212090915;5696.971515142398;5845.09401042839;5858.238429004202;5871.735771890189;5884.852878678067;9754.951225243829;9930.652427165303;9975.750606234611;10143.797124057624;10247.38515689061;9956.253281003808;10147.238957078102;10206.897931020892;10232.744181395525;10294.639687610897;7849.529028258323;8069.829874668258;8186.304164146114;8200.179982001751;8250.257476827115;8477.703280385156;8693.434926729742;8732.56337183151;8795.780105497157;8826.161514656098;8004.439689221698;8051.114377418597;8095.55474448911;8101.149379315323;8175.632096555551;7852.057753069668;7882.054153501616;7959.880601790862;8035.075966263721;8045.798855028671;7157.212706602374;7192.856142877008;7236.312550307713;7250.129984401906;7297.525660832242;4918.508149185053;4964.528369804862;5088.160453525127;5100.515451032146;5182.067227899014;5039.647224694236;5118.718470484159;5177.119889618849;5224.164133738584;5406.162044883049 20:18:20 INFO - PROCESS | 7583 | |4;prototype.html;384.6057790764466;398.32483939722164;399.4268225096986;405.14918670791326;406.6746602717825;5452.91820622691;5495.175723641456;5559.277293951785;5587.944120558793;5626.184203290525;5324.92012619811;5405.162199859028;5428.321459817523;5450.31871016123;5469.972650136754;4335.761533115669;4362.236608593484;4365.978170109161;4371.3661519079715;4377.373575854478;4108.5275193352845;4353.434053573031;4358.433403657536;4371.803268852894;4373.671974601902;4308.655307575402;4315.287977483711;4316.330968699856;4317.222899878021;4326;4317.611414972652;4326;4340.784580317516;4342.761148136867;4347.1957687827535;3809.5999920008553;3837.3092843288196;3919.2357490289405;3919.6864250859862;3920.5491368492703;5226.477352264781;5258.290130832327;5268.868278293035;5282.049231138393;5317.441668624816;4986.229888389606;5005.299258103868;5006.4492905780335;5011.148104822152;5017.84946451607;5432.212329212242;5717.227144834752;5721.456461636138;5770.884582308372;5786.421357864222;4237;4241.981924338136;4256.914861702749;4265.680073994432;4270.487541495009;5985.25184351956;6028.216331876828;6041.794744918117;6045.45590896817;6056.21269235001;4290.4636920384955;4346.9347959780625;4391.099824535962;4400.603945644843;4409.206342858252;4393.7363758174615;4415.845445409395;4425.645948324126;4425.889352766142;4435.3125265583885;5002.1496345621335;5007.198848184273;5021.397432308147;5030.949690503121;5045.672031317952;5621.915671264935;5760.452756988079;5850.8537286567325;5886.6173698709445;5894.581142937086;1460.445030888277;1471.661517850879;1472.417151562075;1476.9218470516582;1477.4385733421445;989.7426669066094;1020.6070662794729;1026.8357062869904;1026.8819085805228;1040.3445829127752;5553.389127196006;5597.580181486404;5603.599100224944;5641.097424412074;5647.491725744702;5750.741216645261;5759.798407055733;5786.652800831964;5794.159846822187;5820.592558520862;5472.890542189213;5522.1776813651395;5542.307211598551;5553.361363443175;5630.662160270397;3019.864106115186;3021.320202954362;3029.1366960416617;3029.7879148459397;3036.7266945974525;5925.851853703692;6022.283649159968;6023.710989823927;6063.272407311151;6103.664298463538;6032.939670603238;6052.727627256784;6055.212822333068;6075.574709770273;6117.449429551361;6246.781362652377;6276.6547839869245;6293.370662933761;6318.8420289492215;6336.303006669263;5626.85932851682;5854.882902342015;5864;5884.382139875252;5968.701564921824;5855.560832937462;5871.706414679335;5875;5897.823065308047;5900.409959004065;5976.731047102978;6143.078538219303;6274.780382686584;6279.246490421178;6307.590006649553;4153.605407486284;4235.407043014042;4263.697603294187;4345.304751239786;4360.626402683145;5925.318588362394;5947.375525569926;5954;5972.790952316648;5977.521798256216;5709.914351284817;5807.315878395218;5817.389174136824;5850.268716410449;5854.063349864001;5791.565632577658;5804.216430781959;5805.954928112811;5807.506361959281;5816.82549523515;5767.163761254511;5811.56413269015;5812.709364531672;5814.098814683562;5851.180834683063;5607.607467477237;5744.655320680772;5755.884882302415;5773.769049237983;5842.582089477703;5649.887002260014;5656.462636049569;5693.886122277614;5696.373398926197;5703.714814259353 20:18:20 INFO - PROCESS | 7583 | |5;yui.html;819.6434550970324;850.5237067242349;854.6965827131369;901.7339884734004;909.4997751236821;16352.264148113334;17580.472585822416;18091.81908180918;18209.635807283845;18386.632267354646;15104.848951510481;15420;16618.66762664746;16865.07242101684;16970.321187152498;821.9876701849477;824.3775949158377;833.4249367936135;833.8290650416681;860.535310932096;856.6659002988808;858.7552547523926;859.0378775771145;859.6991053131417;862.8533149364623;892.0499667853747;894.5884892949251;895.4269267668665;901.7249738829654;902.7833320003217;881.4050515901773;884.1335491218578;885.2431171348469;886.6143227695908;887.3389324952919;652.1098700274139;652.9967350163266;656.583069750707;656.7340227207989;658.0162656828072;17789.19948602303;17991.10044497783;18192.818071819245;18200.90899545507;18250.087495625165;16109.27508262131;16188.595285117848;16306.592335191597;16445;16752.664946701;12515.874841251652;13087.738245235138;13175.14361566495;13178.934105329412;13241;4766.428028636551;4816;4830.806767729287;4830.806767729287;4869;83024;83496.58251708702;85607;85657;85819.57090214509;11463.082953363712;11476.770464590829;11536.077113830874;11555.537778488766;11633.941830290794;23373.7662623375;23656.172033978728;23763.524729505312;23788.405289867893;23924.641130383057;8435.283000944988;8461.95769021151;8512.531810750344;8613.138686131462;8803.031666516677;4677.4854765975715;4705.882352941136;4769.117713223065;4789.257665061921;4797;3654.524911761507;3680.7975561343846;3706.9814650926573;3708.369577171887;3732.309522738302;658.2200092889941;664.6178447392672;671.0973740319263;675.9662016899135;678.4538446550475;612.4243211381288;645.6287634610118;655.8130932684162;660.4617236951868;665.082186582513;10138.722042498974;10276.948615256875;10501.422421766723;10612.0449159576;10823.783524329468;763.207453662409;768.4390395011673;774.4540099230029;774.6785084190111;782.8431031224218;5143.871403214949;5311.973440132774;5354.8661283467445;5416.539594134464;5455.8363249102595;79969;81322.59338703386;82094;83752;84910.15089849145;71575.2842471579;71795.28204717886;72586;72649.91025134627;73202;54848.90302193934;54991.45008549943;62873.371266287664;67721.66139169273;68908.6554567224;10985.296603008446;11112.444377781241;11215.71960700989;11221.775564488502;11355.318680879174;39431;40435.595644043184;40639.59360406358;40896.59103408928;42165.15669686651;45850.77074614605;48402.5159748398;48999;50050.74974625104;53437.19844202262;14478.855211448172;14574;14692.779608306098;14872;14976.47582334613;15328.616784580474;15807.841921581097;16184.126131770261;16270.918645406697;16678.74981875297;15289.770653439984;15379.84620153784;15699.764503532684;15716.449924252596;16117.113558754381;11262.493187806405;12617.306048167438;12882.613521594367;12893.871061289266;13289.401976910869;13243.735125297633;14683.41266349334;14707.264636767904;15355.30901109475;15515.922420388277;12086.274823510617;12142.332171730639;12204.267743935392;12817.359132043546;12877.549285774952;12393.814092788434;12401.201825735037;12416.937915310365;12431.440585173508;12777.509352008963 20:18:20 INFO - PROCESS | 7583 | __end_tp_report 20:18:20 INFO - PROCESS | 7583 | __start_cc_report 20:18:20 INFO - PROCESS | 7583 | _x_x_mozilla_cycle_collect,304 20:18:20 INFO - PROCESS | 7583 | __end_cc_report 20:18:20 INFO - PROCESS | 7583 | __startTimestamp1486354700203__endTimestamp 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | ------- Summary: start ------- 20:18:20 INFO - PROCESS | 7583 | Number of tests: 6 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | [#0] dojo.html Cycles:165 Average:5562.27 Median:5768.51 stddev:609.58 (10.6%) stddev-sans-first:585.30 20:18:20 INFO - PROCESS | 7583 | Values: 3310.6 3324.1 3336.1 3336.4 3354.6 5524.6 5582.0 5582.0 5593.9 5596.9 5575.4 5621.2 5624.2 5638.0 5649.9 5109.6 5121.2 5166.7 5178.1 5182.7 5181.4 5188.9 5192.3 5192.4 5212.7 5007.7 5014.2 5182.5 5185.9 5199.7 5045.5 5088.3 5110.5 5152.7 5196.3 5111.4 5141.8 5167.6 5173.7 5174.0 5356.8 5529.5 5538.4 5601.2 5618.1 5808.0 5867.8 5891.6 5911.8 5919.4 5994.5 6009.9 6025.5 6037.6 6051.8 5617.2 5634.0 5634.5 5637.8 5640.4 5860.7 5884.1 5983.8 6081.0 6103.6 5802.6 5861.1 5879.8 5882.9 5898.1 5951.3 5954.2 5956.3 5959.1 5971.6 5782.9 5805.5 5866.7 5890.7 5912.7 5913.1 5980.7 5981.6 6031.4 6067.1 4571.2 4590.1 4597.7 4605.0 4624.7 3978.0 4106.5 4126.5 4132.6 4143.0 5702.2 5721.2 5745.3 5757.2 5870.4 5970.6 5996.2 6022.8 6026.8 6027.8 5603.8 5608.8 5853.0 5855.7 5857.7 5063.1 5073.8 5075.4 5099.7 5104.5 6321.5 6329.0 6339.6 6341.8 6342.7 5997.4 6007.7 6010.6 6016.5 6020.2 6068.2 6119.0 6141.7 6159.9 6210.2 5840.9 5896.6 5897.3 5909.5 5923.9 5926.5 5996.4 6010.2 6014.1 6016.5 5666.2 5714.9 5766.9 5780.8 5826.1 5840.9 5851.4 5854.6 5858.6 5879.4 5800.9 5811.1 5822.7 5825.4 5834.6 5681.0 5696.2 5737.9 5768.5 5816.0 5688.4 5732.3 5740.3 5745.2 5748.6 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | [#1] ext.html Cycles:180 Average:63577.99 Median:39460.11 stddev:123955.02 (314.1%) stddev-sans-first:124212.37 20:18:20 INFO - PROCESS | 7583 | Values: 533.6 598.9 614.6 728.9 734.4 43372.8 44618.6 48002.3 48055.3 48217.3 48709.3 49676.3 49713.3 49729.0 49754.0 9227.0 10634.5 11000.0 11044.2 11318.5 10956.5 11054.5 11056.5 11057.3 11066.1 11122.7 11164.7 11170.9 11182.4 11192.6 10997.0 11054.1 11068.6 11073.2 11085.5 10823.1 10882.6 10886.3 10932.4 10968.1 42030.8 42322.8 42422.0 42523.4 42816.6 4370.1 4405.3 4423.1 4510.4 4531.8 32056.5 32145.8 32551.3 33138.3 33804.8 4362.3 4475.4 4491.6 4506.2 4560.4 370835.0 370887.0 371168.0 371731.0 373765.0 62974.4 63309.4 63311.4 63939.0 63975.7 60762.4 60845.1 60940.0 60961.4 61102.4 17533.0 17689.3 18055.8 18262.0 18279.1 13323.3 13717.7 13761.3 13768.6 13782.5 19493.8 19704.0 19795.7 19902.9 20061.2 7362.5 7424.0 7564.1 7567.7 7654.0 1018.6 1027.9 1034.8 1044.9 1048.6 33093.8 33225.5 33686.3 33772.5 33982.7 1125.7 1188.1 1188.5 1190.4 1197.7 17585.1 17785.4 17804.6 17871.0 18026.7 568707.0 569859.0 570800.0 572445.0 573642.0 68126.7 68840.3 68973.0 69139.7 69334.0 1554.8 1564.2 1565.3 1568.9 1572.5 32251.0 32271.7 32544.8 32552.7 33398.8 43843.0 43992.0 44048.8 44084.1 44125.6 438033.0 438376.0 439437.0 440933.0 441127.0 28636.3 29229.1 29275.4 29414.3 30670.2 44063.1 46157.3 46646.8 46771.5 47112.0 39744.8 39977.0 40056.0 40578.6 41470.0 38868.6 39329.4 39590.8 40071.0 40431.4 40516.6 40666.4 49486.8 49893.5 49942.8 43276.6 46515.0 48791.0 49052.3 49377.5 37294.7 37567.8 37965.2 38098.8 38152.8 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | [#2] jquery.html Cycles:180 Average:36444.44 Median:22618.16 stddev:112848.48 (498.9%) stddev-sans-first:113132.65 20:18:20 INFO - PROCESS | 7583 | Values: 435.4 437.0 440.7 442.9 453.2 21273.9 21682.7 22384.0 22436.7 22467.7 22368.3 22768.7 22896.4 23147.9 23214.4 5840.8 5871.1 6059.7 6068.6 6081.8 5871.6 5927.6 5974.9 5989.9 6001.5 5799.8 5956.6 5970.3 5979.7 5992.2 5979.0 5988.0 6000.7 6012.8 6015.8 5297.1 5312.1 5375.0 5386.9 5435.3 26004.9 26020.9 26162.7 26175.1 26465.2 3227.2 3329.5 3340.6 3376.4 3406.1 16090.8 16138.2 16302.4 16499.0 16836.6 2029.7 2033.3 2041.4 2062.2 2080.5 83000.6 93209.5 94065.0 95122.5 96748.5 11692.5 11942.5 12070.1 12146.0 12471.5 16635.3 16765.2 16774.2 16785.7 16798.7 8936.2 9044.0 9191.4 9201.5 9226.2 8739.4 8898.8 8944.6 8998.4 9088.8 7527.6 7593.9 7674.0 7678.4 7790.0 2153.4 2171.2 2172.5 2190.6 2232.7 994.4 999.2 1005.7 1009.6 1024.5 21248.8 21459.0 21610.2 21667.5 21702.3 994.7 1008.8 1009.7 1012.6 1039.6 11934.6 12016.3 12121.5 12219.1 12242.9 670816.0 670972.0 672568.0 711200.0 715364.0 93185.0 96117.5 99417.0 99801.5 100647.0 1157.4 1181.5 1201.3 1205.1 1215.8 18325.8 18422.6 18541.4 18738.3 18984.1 43112.8 46107.8 46442.3 50494.7 51564.7 63289.0 66270.7 67923.7 68561.3 68834.7 9811.4 9877.0 10061.0 10162.3 10274.4 11351.4 11421.4 15277.0 15310.7 15477.8 12718.5 12747.3 12780.6 12828.9 12924.5 12254.3 12363.4 12405.2 12669.9 12801.9 12376.9 12836.3 12840.7 13074.7 13124.4 9971.7 10113.8 10122.4 10220.2 10371.5 10579.8 12423.8 12592.2 12633.4 12871.6 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | [#3] mootools.html Cycles:180 Average:5858.93 Median:4986.75 stddev:3366.57 (67.5%) stddev-sans-first:3359.95 20:18:20 INFO - PROCESS | 7583 | Values: 1481.9 1520.7 1538.2 1546.4 1556.3 8563.5 8632.6 8805.2 9237.9 9244.9 8656.7 8746.7 8762.1 8768.0 8819.5 2246.3 2250.3 2279.6 2283.3 2287.3 2357.7 2391.3 2397.5 2401.1 2432.2 2362.7 2366.6 2389.6 2397.8 2404.6 2309.0 2320.0 2325.7 2344.4 2347.7 2367.4 2422.5 2440.9 2443.8 2458.2 9166.6 9241.6 9253.0 9306.7 9325.9 5275.9 5341.3 5387.6 5398.8 5404.6 3278.6 3287.2 3300.6 3317.5 3422.6 1374.5 1398.3 1416.7 1417.5 1461.4 11853.5 12604.6 12619.4 12651.2 12732.1 4434.3 4552.2 4565.9 4603.2 4608.1 9914.6 10039.1 10039.6 10061.2 10070.4 5416.7 5421.2 5436.9 5437.8 5442.2 4836.4 4969.2 5004.3 5038.8 5099.6 3740.0 3795.5 3819.5 3843.6 3868.2 1129.4 1139.2 1145.1 1148.0 1149.7 956.4 988.4 992.6 1001.5 1003.7 5540.3 5621.8 5695.4 5699.3 5745.3 602.0 610.5 615.7 617.1 631.9 3650.0 3716.9 3807.7 3809.1 3959.9 10878.1 11206.1 11256.5 11282.3 11293.0 10985.1 11089.9 11103.5 11116.3 11118.4 8107.7 8409.3 8527.6 8613.3 8754.2 5697.0 5845.1 5858.2 5871.7 5884.9 9755.0 9930.7 9975.8 10143.8 10247.4 9956.3 10147.2 10206.9 10232.7 10294.6 7849.5 8069.8 8186.3 8200.2 8250.3 8477.7 8693.4 8732.6 8795.8 8826.2 8004.4 8051.1 8095.6 8101.1 8175.6 7852.1 7882.1 7959.9 8035.1 8045.8 7157.2 7192.9 7236.3 7250.1 7297.5 4918.5 4964.5 5088.2 5100.5 5182.1 5039.6 5118.7 5177.1 5224.2 5406.2 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | [#4] prototype.html Cycles:180 Average:4896.20 Median:5553.38 stddev:1423.99 (25.6%) stddev-sans-first:1387.14 20:18:20 INFO - PROCESS | 7583 | Values: 384.6 398.3 399.4 405.1 406.7 5452.9 5495.2 5559.3 5587.9 5626.2 5324.9 5405.2 5428.3 5450.3 5470.0 4335.8 4362.2 4366.0 4371.4 4377.4 4108.5 4353.4 4358.4 4371.8 4373.7 4308.7 4315.3 4316.3 4317.2 4326.0 4317.6 4326.0 4340.8 4342.8 4347.2 3809.6 3837.3 3919.2 3919.7 3920.5 5226.5 5258.3 5268.9 5282.0 5317.4 4986.2 5005.3 5006.4 5011.1 5017.8 5432.2 5717.2 5721.5 5770.9 5786.4 4237.0 4242.0 4256.9 4265.7 4270.5 5985.3 6028.2 6041.8 6045.5 6056.2 4290.5 4346.9 4391.1 4400.6 4409.2 4393.7 4415.8 4425.6 4425.9 4435.3 5002.1 5007.2 5021.4 5030.9 5045.7 5621.9 5760.5 5850.9 5886.6 5894.6 1460.4 1471.7 1472.4 1476.9 1477.4 989.7 1020.6 1026.8 1026.9 1040.3 5553.4 5597.6 5603.6 5641.1 5647.5 5750.7 5759.8 5786.7 5794.2 5820.6 5472.9 5522.2 5542.3 5553.4 5630.7 3019.9 3021.3 3029.1 3029.8 3036.7 5925.9 6022.3 6023.7 6063.3 6103.7 6032.9 6052.7 6055.2 6075.6 6117.4 6246.8 6276.7 6293.4 6318.8 6336.3 5626.9 5854.9 5864.0 5884.4 5968.7 5855.6 5871.7 5875.0 5897.8 5900.4 5976.7 6143.1 6274.8 6279.2 6307.6 4153.6 4235.4 4263.7 4345.3 4360.6 5925.3 5947.4 5954.0 5972.8 5977.5 5709.9 5807.3 5817.4 5850.3 5854.1 5791.6 5804.2 5806.0 5807.5 5816.8 5767.2 5811.6 5812.7 5814.1 5851.2 5607.6 5744.7 5755.9 5773.8 5842.6 5649.9 5656.5 5693.9 5696.4 5703.7 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - PROCESS | 7583 | [#5] yui.html Cycles:180 Average:18405.06 Median:25264.13 stddev:22930.14 (90.8%) stddev-sans-first:22956.44 20:18:20 INFO - PROCESS | 7583 | Values: 819.6 850.5 854.7 901.7 909.5 16352.3 17580.5 18091.8 18209.6 18386.6 15104.8 15420.0 16618.7 16865.1 16970.3 822.0 824.4 833.4 833.8 860.5 856.7 858.8 859.0 859.7 862.9 892.0 894.6 895.4 901.7 902.8 881.4 884.1 885.2 886.6 887.3 652.1 653.0 656.6 656.7 658.0 17789.2 17991.1 18192.8 18200.9 18250.1 16109.3 16188.6 16306.6 16445.0 16752.7 12515.9 13087.7 13175.1 13178.9 13241.0 4766.4 4816.0 4830.8 4830.8 4869.0 83024.0 83496.6 85607.0 85657.0 85819.6 11463.1 11476.8 11536.1 11555.5 11633.9 23373.8 23656.2 23763.5 23788.4 23924.6 8435.3 8462.0 8512.5 8613.1 8803.0 4677.5 4705.9 4769.1 4789.3 4797.0 3654.5 3680.8 3707.0 3708.4 3732.3 658.2 664.6 671.1 676.0 678.5 612.4 645.6 655.8 660.5 665.1 10138.7 10276.9 10501.4 10612.0 10823.8 763.2 768.4 774.5 774.7 782.8 5143.9 5312.0 5354.9 5416.5 5455.8 79969.0 81322.6 82094.0 83752.0 84910.2 71575.3 71795.3 72586.0 72649.9 73202.0 54848.9 54991.5 62873.4 67721.7 68908.7 10985.3 11112.4 11215.7 11221.8 11355.3 39431.0 40435.6 40639.6 40896.6 42165.2 45850.8 48402.5 48999.0 50050.7 53437.2 14478.9 14574.0 14692.8 14872.0 14976.5 15328.6 15807.8 16184.1 16270.9 16678.7 15289.8 15379.8 15699.8 15716.4 16117.1 11262.5 12617.3 12882.6 12893.9 13289.4 13243.7 14683.4 14707.3 15355.3 15515.9 12086.3 12142.3 12204.3 12817.4 12877.5 12393.8 12401.2 12416.9 12431.4 12777.5 20:18:20 INFO - PROCESS | 7583 | -------- Summary: end -------- 20:18:20 INFO - PROCESS | 7583 | 20:18:20 INFO - TEST-INFO | 7583: exit 0 20:18:20 INFO - TEST-OK | dromaeo_css | took 1112277ms 20:18:20 INFO - TEST-START | kraken 20:18:20 INFO - operating with platform_type : linux_ 20:18:20 INFO - Initialising browser for kraken test... 20:18:20 INFO - TEST-INFO | started process 7956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfrELr/profile http://localhost:56138/getInfo.html) 20:18:25 INFO - PROCESS | 7956 | __metrics Screen width/height:1600/1200 20:18:25 INFO - PROCESS | 7956 | colorDepth:24 20:18:25 INFO - PROCESS | 7956 | Browser inner width/height: 1024/697 20:18:25 INFO - PROCESS | 7956 | __metrics 20:18:25 INFO - PROCESS | 7956 | 1486354705582 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpEfrELr/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpEfrELr/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpEfrELr/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpEfrELr/profile/extensions/talos-powers@TalosPowersService.js:55:9 20:18:25 ERROR - PROCESS | 7956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:18:26 INFO - TEST-INFO | 7956: exit 0 20:18:26 INFO - Browser initialized. 20:18:26 INFO - Running cycle 1/1 for kraken test... 20:18:26 INFO - TEST-INFO | started process 8083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfrELr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:38 INFO - PROCESS | 8083 | RSS: Main: 144158720 20:18:38 INFO - PROCESS | 8083 | 20:18:40 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56138/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:41 INFO - PROCESS | 8083 | RSS: Main: 151363584 20:18:41 INFO - PROCESS | 8083 | 20:18:44 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56138/tests/kraken/driver.html?testName=audio-dft) 20:18:44 INFO - PROCESS | 8083 | RSS: Main: 150441984 20:18:44 INFO - PROCESS | 8083 | 20:18:47 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56138/tests/kraken/driver.html?testName=audio-fft) 20:18:48 INFO - PROCESS | 8083 | RSS: Main: 150695936 20:18:48 INFO - PROCESS | 8083 | 20:18:50 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56138/tests/kraken/driver.html?testName=audio-oscillator) 20:18:51 INFO - PROCESS | 8083 | RSS: Main: 150495232 20:18:51 INFO - PROCESS | 8083 | 20:18:53 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:53 INFO - PROCESS | 8083 | RSS: Main: 150786048 20:18:53 INFO - PROCESS | 8083 | 20:18:56 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56138/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:57 INFO - PROCESS | 8083 | RSS: Main: 153550848 20:18:57 INFO - PROCESS | 8083 | 20:19:00 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56138/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:01 INFO - PROCESS | 8083 | RSS: Main: 153468928 20:19:01 INFO - PROCESS | 8083 | 20:19:04 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56138/tests/kraken/driver.html?testName=json-parse-financial) 20:19:04 INFO - PROCESS | 8083 | RSS: Main: 152477696 20:19:04 INFO - PROCESS | 8083 | 20:19:06 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:07 INFO - PROCESS | 8083 | RSS: Main: 151900160 20:19:07 INFO - PROCESS | 8083 | 20:19:08 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:09 INFO - PROCESS | 8083 | RSS: Main: 152805376 20:19:09 INFO - PROCESS | 8083 | 20:19:11 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:12 INFO - PROCESS | 8083 | RSS: Main: 153042944 20:19:12 INFO - PROCESS | 8083 | 20:19:14 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:15 INFO - PROCESS | 8083 | RSS: Main: 153858048 20:19:15 INFO - PROCESS | 8083 | 20:19:18 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:18 INFO - PROCESS | 8083 | RSS: Main: 153370624 20:19:18 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | Cycle 1(1): loaded http://localhost:56138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56138/tests/kraken/driver.html?testName=ai-astar) 20:19:20 INFO - PROCESS | 8083 | RSS: Main: 155365376 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | __start_tp_report 20:19:20 INFO - PROCESS | 8083 | _x_x_mozilla_page_load 20:19:20 INFO - PROCESS | 8083 | _x_x_mozilla_page_load_details 20:19:20 INFO - PROCESS | 8083 | |i|pagename|runs| 20:19:20 INFO - PROCESS | 8083 | |0;ai-astar;104;113;113;113;114;115;113;112;111;112 20:19:20 INFO - PROCESS | 8083 | |1;audio-beat-detection;151;123;119;154;120;120;119;118;134;118 20:19:20 INFO - PROCESS | 8083 | |2;audio-dft;163;162;163;162;161;162;161;162;161;163 20:19:20 INFO - PROCESS | 8083 | |3;audio-fft;76;76;74;124;77;75;76;74;107;77 20:19:20 INFO - PROCESS | 8083 | |4;audio-oscillator;82;82;102;85;82;82;93;82;83;101 20:19:20 INFO - PROCESS | 8083 | |5;imaging-gaussian-blur;118;118;118;117;122;122;118;118;117;117 20:19:20 INFO - PROCESS | 8083 | |6;imaging-darkroom;148;149;149;147;148;148;149;149;149;148 20:19:20 INFO - PROCESS | 8083 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;96 20:19:20 INFO - PROCESS | 8083 | |8;json-parse-financial;53;53;55;54;53;55;54;55;54;53 20:19:20 INFO - PROCESS | 8083 | |9;json-stringify-tinderbox;63;64;64;64;65;63;63;63;64;64 20:19:20 INFO - PROCESS | 8083 | |10;stanford-crypto-aes;76;75;75;79;76;79;89;76;76;77 20:19:20 INFO - PROCESS | 8083 | |11;stanford-crypto-ccm;125;134;126;120;126;128;121;128;165;140 20:19:20 INFO - PROCESS | 8083 | |12;stanford-crypto-pbkdf2;156;159;162;157;162;157;162;158;159;170 20:19:20 INFO - PROCESS | 8083 | |13;stanford-crypto-sha256-iterative;61;62;61;69;66;62;66;61;63;59 20:19:20 INFO - PROCESS | 8083 | __end_tp_report 20:19:20 INFO - PROCESS | 8083 | __start_cc_report 20:19:20 INFO - PROCESS | 8083 | _x_x_mozilla_cycle_collect,727 20:19:20 INFO - PROCESS | 8083 | __end_cc_report 20:19:20 INFO - PROCESS | 8083 | __startTimestamp1486354760704__endTimestamp 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | ------- Summary: start ------- 20:19:20 INFO - PROCESS | 8083 | Number of tests: 14 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.02 (2.7%) stddev-sans-first:1.17 20:19:20 INFO - PROCESS | 8083 | Values: 104.0 113.0 113.0 113.0 114.0 115.0 113.0 112.0 111.0 112.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:121.50 stddev:13.96 (11.5%) stddev-sans-first:11.97 20:19:20 INFO - PROCESS | 8083 | Values: 151.0 123.0 119.0 154.0 120.0 120.0 119.0 118.0 134.0 118.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 20:19:20 INFO - PROCESS | 8083 | Values: 163.0 162.0 163.0 162.0 161.0 162.0 161.0 162.0 161.0 163.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:17.32 (22.8%) stddev-sans-first:18.15 20:19:20 INFO - PROCESS | 8083 | Values: 76.0 76.0 74.0 124.0 77.0 75.0 76.0 74.0 107.0 77.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:82.00 stddev:8.17 (10.0%) stddev-sans-first:8.43 20:19:20 INFO - PROCESS | 8083 | Values: 82.0 82.0 102.0 85.0 82.0 82.0 93.0 82.0 83.0 101.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.90 (1.6%) stddev-sans-first:2.01 20:19:20 INFO - PROCESS | 8083 | Values: 118.0 118.0 118.0 117.0 122.0 122.0 118.0 118.0 117.0 117.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 20:19:20 INFO - PROCESS | 8083 | Values: 148.0 149.0 149.0 147.0 148.0 148.0 149.0 149.0 149.0 148.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 20:19:20 INFO - PROCESS | 8083 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 20:19:20 INFO - PROCESS | 8083 | Values: 53.0 53.0 55.0 54.0 53.0 55.0 54.0 55.0 54.0 53.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 20:19:20 INFO - PROCESS | 8083 | Values: 63.0 64.0 64.0 64.0 65.0 63.0 63.0 63.0 64.0 64.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:76.50 stddev:4.18 (5.5%) stddev-sans-first:4.39 20:19:20 INFO - PROCESS | 8083 | Values: 76.0 75.0 75.0 79.0 76.0 79.0 89.0 76.0 76.0 77.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:128.00 stddev:13.21 (10.3%) stddev-sans-first:13.81 20:19:20 INFO - PROCESS | 8083 | Values: 125.0 134.0 126.0 120.0 126.0 128.0 121.0 128.0 165.0 140.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:4.10 (2.6%) stddev-sans-first:4.06 20:19:20 INFO - PROCESS | 8083 | Values: 156.0 159.0 162.0 157.0 162.0 157.0 162.0 158.0 159.0 170.0 20:19:20 INFO - PROCESS | 8083 | 20:19:20 INFO - PROCESS | 8083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:62.50 stddev:3.06 (4.9%) stddev-sans-first:3.15 20:19:20 INFO - PROCESS | 8083 | Values: 61.0 62.0 61.0 69.0 66.0 62.0 66.0 61.0 63.0 59.0 20:19:20 INFO - PROCESS | 8083 | -------- Summary: end -------- 20:19:20 INFO - PROCESS | 8083 | 20:19:21 INFO - TEST-INFO | 8083: exit 0 20:19:21 INFO - TEST-OK | kraken | took 60750ms 20:19:21 INFO - SUITE-END | took 1173s 20:19:21 INFO - Completed test suite (00:19:33) 20:19:21 INFO - javascript benchmark 20:19:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7661.447562813534, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.635830058694, 3324.052644996176, 3336.132605522565, 3336.4494858348376, 3354.580677415323, 5524.585656075796, 5581.972090139544, 5581.972090139554, 5593.888122237553, 5596.916046259309, 5575.358833734122, 5621.212045880542, 5624.15637654352, 5637.9718101409535, 5649.8587535311635, 5109.565686916617, 5121.2318152277085, 5166.664166829144, 5178.093833579127, 5182.740862956856, 5181.4300426953005, 5188.8702782430555, 5192.273081768555, 5192.428832828386, 5212.739363031852, 5007.7496125193775, 5014.222795466709, 5182.507661772125, 5185.948140518584, 5199.68801871887, 5045.545900868921, 5088.287639730441, 5110.514501122388, 5152.742362881841, 5196.29849970253, 5111.361079865017, 5141.76862041209, 5167.638265321429, 5173.715445650488, 5173.9741301293625, 5356.758945847408, 5529.502344788948, 5538.363088244863, 5601.159826026129, 5618.101103823409, 5808.0, 5867.794627188071, 5891.587588868781, 5911.793087241926, 5919.378465261172, 5994.520438364921, 6009.939900601025, 6025.457708806229, 6037.577369584131, 6051.757929682807, 5617.241672374259, 5634.042212823748, 5634.521065709419, 5637.774489020434, 5640.435956404368, 5860.736266868002, 5884.11738239259, 5983.760649574056, 6081.0, 6103.6032657877095, 5802.622829516153, 5861.062230043172, 5879.794207202727, 5882.852928676817, 5898.085796701518, 5951.315598706205, 5954.225950626477, 5956.285245770535, 5959.135925290809, 5971.552133589911, 5782.88434231313, 5805.477507024304, 5866.73599688015, 5890.734916928748, 5912.674802885883, 5913.142594323799, 5980.700964951735, 5981.581289309706, 6031.366706495843, 6067.059605761114, 4571.1543364477675, 4590.059037897223, 4597.7241365518175, 4605.0, 4624.676272660881, 3977.985613668554, 4106.507219133663, 4126.546079931205, 4132.566080561498, 4143.047099167208, 5702.2301989231755, 5721.170430287585, 5745.339285982082, 5757.193992841006, 5870.354261031283, 5970.641761494324, 5996.16053752475, 6022.759089636453, 6026.789062382795, 6027.849303767441, 5603.831885043373, 5608.803691870765, 5852.970735146297, 5855.736491857877, 5857.736401861926, 5063.11395505785, 5073.797048118107, 5075.365579302587, 5099.69401835891, 5104.515071068243, 6321.494280457552, 6329.0, 6339.619622822645, 6341.841453963688, 6342.714577844008, 5997.430244126801, 6007.699615019144, 6010.579259451796, 6016.458518733335, 6020.247469066367, 6068.180795592715, 6119.0, 6141.670122563492, 6159.938400615936, 6210.192674952408, 5840.853978650568, 5896.616719913192, 5897.292324921037, 5909.52723782105, 5923.940760592339, 5926.496247818811, 5996.430339117776, 6010.2186715726675, 6014.0678194879865, 6016.548758843017, 5666.2350582670815, 5714.857128571819, 5766.913496297643, 5780.768769249183, 5826.126081087701, 5840.883182336414, 5851.385604511635, 5854.619449735754, 5858.648481091148, 5879.382664820132, 5800.9419905800405, 5811.070228763378, 5822.70886455684, 5825.3883342248455, 5834.649921004753, 5681.034224181982, 5696.231008813757, 5737.885242295048, 5768.50967667753, 5816.011278082651, 5688.431156884279, 5732.283464566929, 5740.282464691913, 5745.195672605755, 5748.597598168088], "value": 5522.8313315504665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.6168978684324, 598.8532809461683, 614.6496496996713, 728.938040266577, 734.3574372424129, 43372.78313608431, 44618.55381446185, 48002.27996580045, 48055.27917081242, 48217.27674084883, 48709.26936095962, 49676.254856177184, 49713.25430118551, 49729.0, 49754.0, 9226.953865230682, 10634.521446534924, 11000.0, 11044.226904116715, 11318.547258109666, 10956.452177391138, 11054.502547385388, 11056.502457389437, 11057.281276717027, 11066.059384952288, 11122.666320010412, 11164.665060048212, 11170.944145279262, 11182.44087795611, 11192.608258710947, 10997.0, 11054.115670746321, 11068.612598559052, 11073.16951228653, 11085.50115244816, 10823.13414926804, 10882.564697412094, 10886.29239099456, 10932.398718070503, 10968.067714244218, 42030.78984605088, 42322.78838605818, 42422.0, 42523.36214956778, 42816.57183428157, 4370.147821174872, 4405.31717583775, 4423.093265880487, 4510.413646225969, 4531.818727250906, 32056.519152212735, 32145.83927080373, 32551.348973020642, 33138.3372332552, 33804.83097584521, 4362.345648152771, 4475.351074094271, 4491.6182124519455, 4506.188886000518, 4560.384348112995, 370835.0, 370887.0, 371168.0, 371731.0, 373765.0, 62974.37025629777, 63309.36690633127, 63311.36688633055, 63939.0, 63975.68012159909, 60762.39237607656, 60845.08732369018, 60940.0, 60961.39038609646, 61102.38897611056, 17533.0, 17689.292428302982, 18055.819441805677, 18262.0, 18279.086045697662, 13323.267220302976, 13717.725645487035, 13761.31193440324, 13768.586942391745, 13782.517611883535, 19493.75296142037, 19704.01479925998, 19795.703064454046, 19902.90048549777, 20061.197552098045, 7362.484626076231, 7424.0, 7564.130125035581, 7567.697292108364, 7654.0447676218955, 1018.6434747838198, 1027.9023492768174, 1034.8395998620226, 1044.9320794148357, 1048.6067724603274, 33093.83453082719, 33225.501617475755, 33686.32627347439, 33772.53607263251, 33982.66017339844, 1125.6510481750684, 1188.0970462448602, 1188.4830098907003, 1190.36315571169, 1197.6766273106211, 17585.12074396275, 17785.377511787025, 17804.643907121786, 17871.0, 18026.729599056023, 568707.0, 569859.0, 570800.0, 572445.0, 573642.0, 68126.65936670285, 68840.31159688439, 68973.0, 69139.65430172817, 69334.0, 1554.844515548436, 1564.1788061268153, 1565.3269094289565, 1568.9372425103097, 1572.481081243187, 32251.0, 32271.67728322687, 32544.83727581347, 32552.674473254963, 33398.833005834815, 43843.0, 43992.0, 44048.779756101016, 44084.11831763411, 44125.55874441343, 438033.0, 438376.0, 439437.0, 440933.0, 441127.0, 28636.28409289701, 29229.123126306244, 29275.41449171047, 29414.264643384086, 30670.233244169074, 44063.11873762443, 46157.30764038609, 46646.76676616731, 46771.53228467808, 47112.0, 39744.801275993435, 39977.0, 40056.0, 40578.59421405866, 41470.0, 38868.61131388763, 39329.41005884971, 39590.802045989585, 40071.0, 40431.39352909767, 40516.594834051284, 40666.39000414937, 49486.75256623694, 49893.501064988886, 49942.75028624979, 43276.56723432725, 46515.0, 48791.0, 49052.2642160375, 49377.50622493729, 37294.68888622528, 37567.81216093902, 37965.24069518649, 38098.80950595229, 38152.809235953646], "value": 21876.212899802857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.43828461284943, 436.99563004369946, 440.7047278323523, 442.9490608580013, 453.21593642997635, 21273.893630531864, 21682.674759878613, 22384.0, 22436.66345004826, 22467.662985055238, 22368.328950131483, 22768.65847012292, 22896.427589310235, 23147.884260578674, 23214.419639509022, 5840.795572154975, 5871.089981052923, 6059.727312270937, 6068.57519973602, 6081.817545473643, 5871.559633027518, 5927.644341339512, 5974.850628734294, 5989.85025374367, 6001.519878409738, 5799.797007104752, 5956.583039187259, 5970.253718285215, 5979.671118088525, 5992.191054207691, 5978.9701051494685, 5988.041913293874, 6000.729967151467, 6012.789552365646, 6015.75936962521, 5297.073012222884, 5312.07038768214, 5375.0, 5386.91919621206, 5435.266239057755, 26004.86997565019, 26020.8698956504, 26162.73837261622, 26175.083872064577, 26465.206043818715, 3227.1766451954572, 3329.467285234351, 3340.599128104643, 3376.4428869236544, 3406.131436483706, 16090.83909160905, 16138.193090345436, 16302.429414970418, 16499.0, 16836.579085522837, 2029.7056926745686, 2033.30867505049, 2041.3671761753756, 2062.226665000625, 2080.5422806982438, 83000.58499707463, 93209.5339523298, 94065.0, 95122.52438737832, 96748.51625741896, 11692.47383867728, 11942.522299108112, 12070.094742894318, 12146.0, 12471.5011399543, 16635.251413686412, 16765.24556394965, 16774.161291935354, 16785.748213776802, 16798.748018779726, 8936.151065648754, 9043.954780226188, 9191.402558833788, 9201.539923003957, 9226.169644732006, 8739.388242823068, 8898.777530561787, 8944.597493112826, 8998.370114091951, 9088.772780680536, 7527.623618819037, 7593.924060759432, 7674.0, 7678.424118191158, 7790.0, 2153.407812851447, 2171.2183613898983, 2172.500324925276, 2190.6494960806513, 2232.676261942009, 994.3785134291068, 999.205631522941, 1005.6731562242301, 1009.5608410341525, 1024.5235965276183, 21248.78751212499, 21459.0, 21610.243641472473, 21667.458313542287, 21702.348929532138, 994.6767300627181, 1008.7528555503949, 1009.7425156585024, 1012.584840215508, 1039.6309310194922, 11934.582289619822, 12016.279023258632, 12121.515139394502, 12219.144659873902, 12242.938785306016, 670816.0, 670972.0, 672568.0, 711200.0, 715364.0, 93185.0, 96117.51941240249, 99417.0, 99801.50099249458, 100647.0, 1157.3576664951033, 1181.5037684172669, 1201.2732296960387, 1205.0600531585378, 1215.8237055627062, 18325.816741832412, 18422.631547369245, 18541.44375668732, 18738.344157954405, 18984.050797459797, 43112.78443607887, 46107.76946115248, 46442.30336544887, 50494.74752626213, 51564.74217628888, 63289.0, 66270.66864665646, 67923.66038169777, 68561.31438685748, 68834.65582672054, 9811.411315321104, 9876.950615246878, 10061.0, 10162.288639795439, 10274.383536987805, 11351.432428378383, 11421.428928553372, 15277.0, 15310.693786123993, 15477.84522154764, 12718.491260349483, 12747.298898560668, 12780.552680656132, 12828.935855320664, 12924.547640832525, 12254.264744115382, 12363.443645035815, 12405.193662411913, 12669.873301266869, 12801.871981280068, 12376.876231237573, 12836.294003829878, 12840.678983025498, 13074.738505229652, 13124.409401577142, 9971.700848974542, 10113.848292275474, 10122.374229251209, 10220.182385409298, 10371.533281002223, 10579.788404231718, 12423.751524969632, 12592.181508201938, 12633.3683315832, 12871.613851584467], "value": 10461.146190635423, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.925903704816, 1520.680657062017, 1538.246259332927, 1546.4278217059682, 1556.315221302626, 8563.529005904687, 8632.611532481038, 8805.20753132218, 9237.861432078516, 9244.907550924498, 8656.697015604455, 8746.737597872074, 8762.123787621234, 8768.035516093225, 8819.470831750099, 2246.292417888364, 2250.2911582851348, 2279.5668822923676, 2283.280766558537, 2287.3023727763025, 2357.6581395697613, 2391.330427480308, 2397.4845408237225, 2401.0515846240723, 2432.1609044879488, 2362.7400985891536, 2366.5740166769974, 2389.6176611742126, 2397.820163487737, 2404.5791986402396, 2308.988455057722, 2320.0, 2325.6976593042796, 2344.355302291875, 2347.6713260143592, 2367.419982104378, 2422.454947636785, 2440.9389765255833, 2443.7556244375596, 2458.225658917453, 9166.587503562356, 9241.584128714225, 9252.95373523128, 9306.67426640071, 9325.906740932573, 5275.947240527584, 5341.305630268079, 5387.568994480433, 5398.757055932492, 5404.648697834628, 3278.639349671534, 3287.227501537137, 3300.626221530864, 3317.5023746437987, 3422.5892892853017, 1374.4845682868925, 1398.258922770923, 1416.744985902537, 1417.4613646814144, 1461.4373466215584, 11853.46659400329, 12604.55884044054, 12619.432125554373, 12651.177673451288, 12732.108752387336, 4434.290513517822, 4552.245891235754, 4565.863024109282, 4603.194440972883, 4608.124456353282, 9914.55384507699, 10039.09648131657, 10039.598416063422, 10061.19510439163, 10070.44612546317, 5416.729163541886, 5421.2139239810795, 5436.885438485101, 5437.8368648940595, 5442.183672449164, 4836.419629644465, 4969.155243608595, 5004.3494345734825, 5038.773255203525, 5099.59203263738, 3739.962600374016, 3795.525559305087, 3819.52255968004, 3843.557990831034, 3868.2456920900154, 1129.4465711801158, 1139.202558209257, 1145.0953746540306, 1148.0356500539588, 1149.735560821016, 956.3687965942445, 988.41189492252, 992.6277645882794, 1001.5142655812072, 1003.6637726361605, 5540.335159780852, 5621.775128994795, 5695.373508914016, 5699.2590963174525, 5745.2818397700285, 602.036741214054, 610.4536439886277, 615.7352338494491, 617.1360095865734, 631.8767840271103, 3650.0, 3716.888493345204, 3807.7334586578672, 3809.066778639251, 3959.8812035638975, 10878.129749620011, 11206.103511719042, 11256.549738010388, 11282.323060616389, 11293.0, 10985.121190304757, 11089.889101109047, 11103.500342484607, 11116.277441966246, 11118.388488633203, 8107.716229931924, 8409.32725381968, 8527.616257268437, 8613.310935125175, 8754.21212090915, 5696.971515142398, 5845.09401042839, 5858.238429004202, 5871.735771890189, 5884.852878678067, 9754.951225243829, 9930.652427165303, 9975.750606234611, 10143.797124057624, 10247.38515689061, 9956.253281003808, 10147.238957078102, 10206.897931020892, 10232.744181395525, 10294.639687610897, 7849.529028258323, 8069.829874668258, 8186.304164146114, 8200.179982001751, 8250.257476827115, 8477.703280385156, 8693.434926729742, 8732.56337183151, 8795.780105497157, 8826.161514656098, 8004.439689221698, 8051.114377418597, 8095.55474448911, 8101.149379315323, 8175.632096555551, 7852.057753069668, 7882.054153501616, 7959.880601790862, 8035.075966263721, 8045.798855028671, 7157.212706602374, 7192.856142877008, 7236.312550307713, 7250.129984401906, 7297.525660832242, 4918.508149185053, 4964.528369804862, 5088.160453525127, 5100.515451032146, 5182.067227899014, 5039.647224694236, 5118.718470484159, 5177.119889618849, 5224.164133738584, 5406.162044883049], "value": 4636.583555527385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.6057790764466, 398.32483939722164, 399.4268225096986, 405.14918670791326, 406.6746602717825, 5452.91820622691, 5495.175723641456, 5559.277293951785, 5587.944120558793, 5626.184203290525, 5324.92012619811, 5405.162199859028, 5428.321459817523, 5450.31871016123, 5469.972650136754, 4335.761533115669, 4362.236608593484, 4365.978170109161, 4371.3661519079715, 4377.373575854478, 4108.5275193352845, 4353.434053573031, 4358.433403657536, 4371.803268852894, 4373.671974601902, 4308.655307575402, 4315.287977483711, 4316.330968699856, 4317.222899878021, 4326.0, 4317.611414972652, 4326.0, 4340.784580317516, 4342.761148136867, 4347.1957687827535, 3809.5999920008553, 3837.3092843288196, 3919.2357490289405, 3919.6864250859862, 3920.5491368492703, 5226.477352264781, 5258.290130832327, 5268.868278293035, 5282.049231138393, 5317.441668624816, 4986.229888389606, 5005.299258103868, 5006.4492905780335, 5011.148104822152, 5017.84946451607, 5432.212329212242, 5717.227144834752, 5721.456461636138, 5770.884582308372, 5786.421357864222, 4237.0, 4241.981924338136, 4256.914861702749, 4265.680073994432, 4270.487541495009, 5985.25184351956, 6028.216331876828, 6041.794744918117, 6045.45590896817, 6056.21269235001, 4290.4636920384955, 4346.9347959780625, 4391.099824535962, 4400.603945644843, 4409.206342858252, 4393.7363758174615, 4415.845445409395, 4425.645948324126, 4425.889352766142, 4435.3125265583885, 5002.1496345621335, 5007.198848184273, 5021.397432308147, 5030.949690503121, 5045.672031317952, 5621.915671264935, 5760.452756988079, 5850.8537286567325, 5886.6173698709445, 5894.581142937086, 1460.445030888277, 1471.661517850879, 1472.417151562075, 1476.9218470516582, 1477.4385733421445, 989.7426669066094, 1020.6070662794729, 1026.8357062869904, 1026.8819085805228, 1040.3445829127752, 5553.389127196006, 5597.580181486404, 5603.599100224944, 5641.097424412074, 5647.491725744702, 5750.741216645261, 5759.798407055733, 5786.652800831964, 5794.159846822187, 5820.592558520862, 5472.890542189213, 5522.1776813651395, 5542.307211598551, 5553.361363443175, 5630.662160270397, 3019.864106115186, 3021.320202954362, 3029.1366960416617, 3029.7879148459397, 3036.7266945974525, 5925.851853703692, 6022.283649159968, 6023.710989823927, 6063.272407311151, 6103.664298463538, 6032.939670603238, 6052.727627256784, 6055.212822333068, 6075.574709770273, 6117.449429551361, 6246.781362652377, 6276.6547839869245, 6293.370662933761, 6318.8420289492215, 6336.303006669263, 5626.85932851682, 5854.882902342015, 5864.0, 5884.382139875252, 5968.701564921824, 5855.560832937462, 5871.706414679335, 5875.0, 5897.823065308047, 5900.409959004065, 5976.731047102978, 6143.078538219303, 6274.780382686584, 6279.246490421178, 6307.590006649553, 4153.605407486284, 4235.407043014042, 4263.697603294187, 4345.304751239786, 4360.626402683145, 5925.318588362394, 5947.375525569926, 5954.0, 5972.790952316648, 5977.521798256216, 5709.914351284817, 5807.315878395218, 5817.389174136824, 5850.268716410449, 5854.063349864001, 5791.565632577658, 5804.216430781959, 5805.954928112811, 5807.506361959281, 5816.82549523515, 5767.163761254511, 5811.56413269015, 5812.709364531672, 5814.098814683562, 5851.180834683063, 5607.607467477237, 5744.655320680772, 5755.884882302415, 5773.769049237983, 5842.582089477703, 5649.887002260014, 5656.462636049569, 5693.886122277614, 5696.373398926197, 5703.714814259353], "value": 4456.672113412509, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.6434550970324, 850.5237067242349, 854.6965827131369, 901.7339884734004, 909.4997751236821, 16352.264148113334, 17580.472585822416, 18091.81908180918, 18209.635807283845, 18386.632267354646, 15104.848951510481, 15420.0, 16618.66762664746, 16865.07242101684, 16970.321187152498, 821.9876701849477, 824.3775949158377, 833.4249367936135, 833.8290650416681, 860.535310932096, 856.6659002988808, 858.7552547523926, 859.0378775771145, 859.6991053131417, 862.8533149364623, 892.0499667853747, 894.5884892949251, 895.4269267668665, 901.7249738829654, 902.7833320003217, 881.4050515901773, 884.1335491218578, 885.2431171348469, 886.6143227695908, 887.3389324952919, 652.1098700274139, 652.9967350163266, 656.583069750707, 656.7340227207989, 658.0162656828072, 17789.19948602303, 17991.10044497783, 18192.818071819245, 18200.90899545507, 18250.087495625165, 16109.27508262131, 16188.595285117848, 16306.592335191597, 16445.0, 16752.664946701, 12515.874841251652, 13087.738245235138, 13175.14361566495, 13178.934105329412, 13241.0, 4766.428028636551, 4816.0, 4830.806767729287, 4830.806767729287, 4869.0, 83024.0, 83496.58251708702, 85607.0, 85657.0, 85819.57090214509, 11463.082953363712, 11476.770464590829, 11536.077113830874, 11555.537778488766, 11633.941830290794, 23373.7662623375, 23656.172033978728, 23763.524729505312, 23788.405289867893, 23924.641130383057, 8435.283000944988, 8461.95769021151, 8512.531810750344, 8613.138686131462, 8803.031666516677, 4677.4854765975715, 4705.882352941136, 4769.117713223065, 4789.257665061921, 4797.0, 3654.524911761507, 3680.7975561343846, 3706.9814650926573, 3708.369577171887, 3732.309522738302, 658.2200092889941, 664.6178447392672, 671.0973740319263, 675.9662016899135, 678.4538446550475, 612.4243211381288, 645.6287634610118, 655.8130932684162, 660.4617236951868, 665.082186582513, 10138.722042498974, 10276.948615256875, 10501.422421766723, 10612.0449159576, 10823.783524329468, 763.207453662409, 768.4390395011673, 774.4540099230029, 774.6785084190111, 782.8431031224218, 5143.871403214949, 5311.973440132774, 5354.8661283467445, 5416.539594134464, 5455.8363249102595, 79969.0, 81322.59338703386, 82094.0, 83752.0, 84910.15089849145, 71575.2842471579, 71795.28204717886, 72586.0, 72649.91025134627, 73202.0, 54848.90302193934, 54991.45008549943, 62873.371266287664, 67721.66139169273, 68908.6554567224, 10985.296603008446, 11112.444377781241, 11215.71960700989, 11221.775564488502, 11355.318680879174, 39431.0, 40435.595644043184, 40639.59360406358, 40896.59103408928, 42165.15669686651, 45850.77074614605, 48402.5159748398, 48999.0, 50050.74974625104, 53437.19844202262, 14478.855211448172, 14574.0, 14692.779608306098, 14872.0, 14976.47582334613, 15328.616784580474, 15807.841921581097, 16184.126131770261, 16270.918645406697, 16678.74981875297, 15289.770653439984, 15379.84620153784, 15699.764503532684, 15716.449924252596, 16117.113558754381, 11262.493187806405, 12617.306048167438, 12882.613521594367, 12893.871061289266, 13289.401976910869, 13243.735125297633, 14683.41266349334, 14707.264636767904, 15355.30901109475, 15515.922420388277, 12086.274823510617, 12142.332171730639, 12204.267743935392, 12817.359132043546, 12877.549285774952, 12393.814092788434, 12401.201825735037, 12416.937915310365, 12431.440585173508, 12777.509352008963], "value": 7742.762744334584, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 113.0, 114.0, 115.0, 113.0, 112.0, 111.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 119.0, 154.0, 120.0, 120.0, 119.0, 118.0, 134.0, 118.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 124.0, 77.0, 75.0, 76.0, 74.0, 107.0, 77.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 102.0, 85.0, 82.0, 82.0, 93.0, 82.0, 83.0, 101.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 122.0, 122.0, 118.0, 118.0, 117.0, 117.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 147.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 54.0, 53.0, 55.0, 54.0, 55.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 79.0, 76.0, 79.0, 89.0, 76.0, 76.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 134.0, 126.0, 120.0, 126.0, 128.0, 121.0, 128.0, 165.0, 140.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 162.0, 157.0, 162.0, 157.0, 162.0, 158.0, 159.0, 170.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 69.0, 66.0, 62.0, 66.0, 61.0, 63.0, 59.0], "value": 63.0, "unit": "score"}]}]} 20:19:21 INFO - Return code: 0 20:19:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:19:22 ERROR - # TBPL SUCCESS # 20:19:22 INFO - Running post-action listener: _resource_record_post_action 20:19:22 INFO - [mozharness: 2017-02-06 04:19:22.022496Z] Finished run-tests step (success) 20:19:22 INFO - Running post-run listener: _resource_record_post_run 20:19:22 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361533440; Read time: 12; Write time: 207504 20:19:22 INFO - TinderboxPrint: CPU usage
13.3% 20:19:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:19:22 INFO - TinderboxPrint: I/O write bytes / time
361,533,440 / 207,504 20:19:22 INFO - TinderboxPrint: CPU idle
8,232.8 (86.7%) 20:19:22 INFO - TinderboxPrint: CPU user
1,206.6 (12.7%) 20:19:22 INFO - TinderboxPrint: Swap in / out
0 / 0 20:19:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110030848; Read time: 0; Write time: 96880 20:19:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251502592; Read time: 12; Write time: 110624 20:19:22 INFO - Running post-run listener: _upload_blobber_files 20:19:22 INFO - Blob upload gear active. 20:19:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:19:22 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 20:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:19:23 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:23 INFO - (blobuploader) - INFO - Done attempting. 20:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:26 INFO - (blobuploader) - INFO - Done attempting. 20:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:27 INFO - (blobuploader) - INFO - Done attempting. 20:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:28 INFO - (blobuploader) - INFO - Done attempting. 20:19:28 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:28 INFO - Return code: 0 20:19:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:19:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b348dfdec72751398521b2e2537a375624aeb3806d764ec9b519b897b7d4836cbfef64495882dc96ce7bd1c04fe978a0db9ebae5a5979d548a9bd8401a83a9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e641ec5788e642ea0986a90a65894b840ce2d23dcf463073aea260237a125ae8758938bdc0b3cd6d1766c4b163c6ecad1cbbcd96b130d82663ced160130c9733", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad4d6267520610f0a7a0091bf4d2ba50e085c670120484598db836445a721352800cab067657e8b90c185c83f7a9f65f31759a1a32016d0df1a1654c340f3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b8529a46b2e7235cd1b9832fd62726f126f73daaeed7e5b653f2a2762018703fa4a90382bad0ab61d4b7e5a773e0f5921cd7fa99358c318f076204a5af8055"} 20:19:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:19:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:19:28 INFO - Contents: 20:19:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b348dfdec72751398521b2e2537a375624aeb3806d764ec9b519b897b7d4836cbfef64495882dc96ce7bd1c04fe978a0db9ebae5a5979d548a9bd8401a83a9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e641ec5788e642ea0986a90a65894b840ce2d23dcf463073aea260237a125ae8758938bdc0b3cd6d1766c4b163c6ecad1cbbcd96b130d82663ced160130c9733", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad4d6267520610f0a7a0091bf4d2ba50e085c670120484598db836445a721352800cab067657e8b90c185c83f7a9f65f31759a1a32016d0df1a1654c340f3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b8529a46b2e7235cd1b9832fd62726f126f73daaeed7e5b653f2a2762018703fa4a90382bad0ab61d4b7e5a773e0f5921cd7fa99358c318f076204a5af8055"} 20:19:28 INFO - Running post-run listener: copy_logs_to_upload_dir 20:19:28 INFO - Copying logs to upload dir... 20:19:28 INFO - mkdir: /builds/slave/test/build/upload/logs 20:19:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.699591 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-05 20:19:26.575091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 20:19:26.579029) ========= 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-1486353532.415659-605005268 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/Mozilla-Aurora/sha512/0b348dfdec72751398521b2e2537a375624aeb3806d764ec9b519b897b7d4836cbfef64495882dc96ce7bd1c04fe978a0db9ebae5a5979d548a9bd8401a83a9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e641ec5788e642ea0986a90a65894b840ce2d23dcf463073aea260237a125ae8758938bdc0b3cd6d1766c4b163c6ecad1cbbcd96b130d82663ced160130c9733", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad4d6267520610f0a7a0091bf4d2ba50e085c670120484598db836445a721352800cab067657e8b90c185c83f7a9f65f31759a1a32016d0df1a1654c340f3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b8529a46b2e7235cd1b9832fd62726f126f73daaeed7e5b653f2a2762018703fa4a90382bad0ab61d4b7e5a773e0f5921cd7fa99358c318f076204a5af8055"} build_url:https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011538 build_url: 'https://queue.taskcluster.net/v1/task/M8kGUwdyS8uANgiefunbVQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b348dfdec72751398521b2e2537a375624aeb3806d764ec9b519b897b7d4836cbfef64495882dc96ce7bd1c04fe978a0db9ebae5a5979d548a9bd8401a83a9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e641ec5788e642ea0986a90a65894b840ce2d23dcf463073aea260237a125ae8758938bdc0b3cd6d1766c4b163c6ecad1cbbcd96b130d82663ced160130c9733", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad4d6267520610f0a7a0091bf4d2ba50e085c670120484598db836445a721352800cab067657e8b90c185c83f7a9f65f31759a1a32016d0df1a1654c340f3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1b8529a46b2e7235cd1b9832fd62726f126f73daaeed7e5b653f2a2762018703fa4a90382bad0ab61d4b7e5a773e0f5921cd7fa99358c318f076204a5af8055"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 20:19:26.603564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 20:19:26.603902) ========= 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-1486353532.415659-605005268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 20:19:26.686405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 20:19:26.686737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 20:19:26.687026) ========= ========= Total master_lag: 0.16 =========