builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1486457736.0 results: success (0) revision: 4116e3e124601c356950880ad01f015626b21345 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:35.996633) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:35.997105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:35.997378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:36.010999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:36.011303) ========= 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=1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-07 00:55:36-- 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% 119M=0s 2017-02-07 00:55:36 (119 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:36.198833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:36.199157) ========= 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=1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015362 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:36.248277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:36.248616) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4116e3e124601c356950880ad01f015626b21345 --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 4116e3e124601c356950880ad01f015626b21345 --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=1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-07 00:55:36,514 truncating revision to first 12 chars 2017-02-07 00:55:36,514 Setting DEBUG logging. 2017-02-07 00:55:36,514 attempt 1/10 2017-02-07 00:55:36,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4116e3e12460?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 00:55:36,953 unpacking tar archive at: mozilla-aurora-4116e3e12460/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747614 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:37.077491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:37.077830) ========= script_repo_revision: 4116e3e124601c356950880ad01f015626b21345 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:37.078200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:37.078462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 00:55:37.089082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-02-07 00:55:37.089463) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] 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=1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:55:37 INFO - MultiFileLogger online at 20170207 00:55:37 in /builds/slave/test 00:55:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 00:55:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:55:37 INFO - {'append_to_log': False, 00:55:37 INFO - 'base_work_dir': '/builds/slave/test', 00:55:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 00:55:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:55:37 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 00:55:37 INFO - 'buildbot_json_path': 'buildprops.json', 00:55:37 INFO - 'config_files': ('talos/linux_config.py',), 00:55:37 INFO - 'default_actions': ('clobber', 00:55:37 INFO - 'read-buildbot-config', 00:55:37 INFO - 'download-and-extract', 00:55:37 INFO - 'populate-webroot', 00:55:37 INFO - 'create-virtualenv', 00:55:37 INFO - 'install', 00:55:37 INFO - 'run-tests'), 00:55:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:55:37 INFO - 'download_minidump_stackwalk': True, 00:55:37 INFO - 'download_symbols': 'ondemand', 00:55:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:55:37 INFO - 'tooltool.py': '/tools/tooltool.py', 00:55:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:55:37 INFO - '/tools/misc-python/virtualenv.py')}, 00:55:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:55:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:55:37 INFO - 'installer_path': 'installer.exe', 00:55:37 INFO - 'log_level': 'info', 00:55:37 INFO - 'log_name': 'talos', 00:55:37 INFO - 'log_to_console': True, 00:55:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:55:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:55:37 INFO - 'opt_config_files': (), 00:55:37 INFO - 'pip_index': False, 00:55:37 INFO - 'sps_profile': False, 00:55:37 INFO - 'sps_profile_interval': 0, 00:55:37 INFO - 'suite': 'dromaeojs-e10s', 00:55:37 INFO - 'system_bits': '32', 00:55:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:55:37 INFO - 'title': 'talos-linux64-ix-027', 00:55:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:55:37 INFO - 'use_talos_json': True, 00:55:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:55:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:55:37 INFO - 'work_dir': 'build'} 00:55:37 INFO - [mozharness: 2017-02-07 08:55:37.453757Z] Running clobber step. 00:55:37 INFO - Running pre-action listener: _resource_record_pre_action 00:55:37 INFO - Running main action method: clobber 00:55:37 INFO - rmtree: /builds/slave/test/build 00:55:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:55:38 INFO - Running post-action listener: _resource_record_post_action 00:55:38 INFO - [mozharness: 2017-02-07 08:55:38.447882Z] Finished clobber step (success) 00:55:38 INFO - [mozharness: 2017-02-07 08:55:38.447981Z] Running read-buildbot-config step. 00:55:38 INFO - Running pre-action listener: _resource_record_pre_action 00:55:38 INFO - Running main action method: read_buildbot_config 00:55:38 INFO - Using buildbot properties: 00:55:38 INFO - { 00:55:38 INFO - "project": "", 00:55:38 INFO - "product": "firefox", 00:55:38 INFO - "who": "cbook@mozilla.com", 00:55:38 INFO - "installer_path": "public/build/target.tar.bz2", 00:55:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 00:55:38 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 00:55:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 00:55:38 INFO - "stage_platform": "linux64", 00:55:38 INFO - "basedir": "/builds/slave/test", 00:55:38 INFO - "buildnumber": 18, 00:55:38 INFO - "platform": "ubuntu64_hw", 00:55:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:55:38 INFO - "slavebuilddir": "test", 00:55:38 INFO - "taskId": "VBZyr49sTVObfCuuxVp-FA", 00:55:38 INFO - "branch": "mozilla-aurora", 00:55:38 INFO - "script_repo_revision": "production", 00:55:38 INFO - "revision": "4116e3e124601c356950880ad01f015626b21345", 00:55:38 INFO - "slavename": "talos-linux64-ix-027", 00:55:38 INFO - "repo_path": "releases/mozilla-aurora" 00:55:38 INFO - } 00:55:38 INFO - Finding installer, test and symbols from parent task. 00:55:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBZyr49sTVObfCuuxVp-FA'}, attempt #1 00:55:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBZyr49sTVObfCuuxVp-FA'}, attempt #1 00:55:39 INFO - Task dependencies: UKCxlCurS26kUJ6Jv-tR9g 00:55:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g'}, attempt #1 00:55:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:55:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/test_packages.json 00:55:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.crashreporter-symbols.zip 00:55:39 INFO - Running post-action listener: _resource_record_post_action 00:55:39 INFO - [mozharness: 2017-02-07 08:55:39.831476Z] Finished read-buildbot-config step (success) 00:55:39 INFO - [mozharness: 2017-02-07 08:55:39.831694Z] Running download-and-extract step. 00:55:39 INFO - Running pre-action listener: _resource_record_pre_action 00:55:39 INFO - Running main action method: download_and_extract 00:55:39 INFO - mkdir: /builds/slave/test/build/tests 00:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:39 INFO - trying https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.test_packages.json 00:55:39 INFO - Downloading https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:55:40 INFO - Downloaded 896 bytes. 00:55:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:55:40 INFO - Using the following test package requirements: 00:55:40 INFO - {u'common': [u'target.common.tests.zip'], 00:55:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:55:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:55:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:55:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:55:40 INFO - u'mozbase': [u'target.common.tests.zip'], 00:55:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:55:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:55:40 INFO - u'web-platform': [u'target.common.tests.zip', 00:55:40 INFO - u'target.web-platform.tests.zip'], 00:55:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:55:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 00:55:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip 00:55:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:55:40 INFO - Fetch https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip into memory 00:55:42 INFO - Expected file size: 21855405 00:55:42 INFO - Obtained file size: 21855405 00:55:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 00:55:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip 00:55:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:55:46 INFO - Fetch https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip into memory 00:55:47 INFO - Expected file size: 21855405 00:55:47 INFO - Obtained file size: 21855405 00:55:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.talos.tests.zip 00:55:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:55:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.talos.tests.zip into memory 00:55:53 INFO - Expected file size: 14403485 00:55:53 INFO - Obtained file size: 14403485 00:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:53 INFO - trying https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:55:55 INFO - Downloaded 66085688 bytes. 00:55:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:55:55 INFO - mkdir: /builds/slave/test/properties 00:55:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:55:55 INFO - Writing to file /builds/slave/test/properties/build_url 00:55:55 INFO - Contents: 00:55:55 INFO - build_url:https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:55:55 INFO - Running post-action listener: _resource_record_post_action 00:55:55 INFO - Running post-action listener: set_extra_try_arguments 00:55:55 INFO - [mozharness: 2017-02-07 08:55:55.818787Z] Finished download-and-extract step (success) 00:55:55 INFO - [mozharness: 2017-02-07 08:55:55.818884Z] Running populate-webroot step. 00:55:55 INFO - Running pre-action listener: _resource_record_pre_action 00:55:55 INFO - Running main action method: populate_webroot 00:55:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:55:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:55:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:55:55 INFO - '--tppagecycles', 00:55:55 INFO - '7'], 00:55:55 INFO - 'tests': ['tsvgm']}}, 00:55:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:55:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:55:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:55:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:55:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:55:55 INFO - 'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:55:55 INFO - 'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['damp', 'tps']}, 00:55:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:55:55 INFO - 'tests': ['damp', 'tps']}, 00:55:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['dromaeo_dom']}, 00:55:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:55:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['basic_compositor_video']}, 00:55:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:55:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['a11yr', 00:55:55 INFO - 'ts_paint', 00:55:55 INFO - 'tpaint', 00:55:55 INFO - 'sessionrestore', 00:55:55 INFO - 'sessionrestore_no_auto_restore', 00:55:55 INFO - 'tabpaint']}, 00:55:55 INFO - 'other-e10s': {'tests': ['a11yr', 00:55:55 INFO - 'ts_paint', 00:55:55 INFO - 'tpaint', 00:55:55 INFO - 'sessionrestore', 00:55:55 INFO - 'sessionrestore_no_auto_restore', 00:55:55 INFO - 'tabpaint']}, 00:55:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:55:55 INFO - 'ts_paint', 00:55:55 INFO - 'tpaint', 00:55:55 INFO - 'sessionrestore', 00:55:55 INFO - 'sessionrestore_no_auto_restore', 00:55:55 INFO - 'tabpaint']}, 00:55:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:55:55 INFO - 'ts_paint', 00:55:55 INFO - 'tpaint', 00:55:55 INFO - 'sessionrestore', 00:55:55 INFO - 'sessionrestore_no_auto_restore', 00:55:55 INFO - 'tabpaint']}, 00:55:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['a11yr', 00:55:55 INFO - 'ts_paint', 00:55:55 INFO - 'tpaint', 00:55:55 INFO - 'sessionrestore', 00:55:55 INFO - 'sessionrestore_no_auto_restore', 00:55:55 INFO - 'tabpaint']}, 00:55:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['a11yr', 00:55:55 INFO - 'ts_paint', 00:55:55 INFO - 'tpaint', 00:55:55 INFO - 'sessionrestore', 00:55:55 INFO - 'sessionrestore_no_auto_restore', 00:55:55 INFO - 'tabpaint']}, 00:55:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['tsvgx', 00:55:55 INFO - 'tsvgr_opacity', 00:55:55 INFO - 'tart', 00:55:55 INFO - 'tscrollx', 00:55:55 INFO - 'cart', 00:55:55 INFO - 'tsvg_static']}, 00:55:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:55:55 INFO - 'tsvgr_opacity', 00:55:55 INFO - 'tart', 00:55:55 INFO - 'tscrollx', 00:55:55 INFO - 'cart', 00:55:55 INFO - 'tsvg_static']}, 00:55:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:55:55 INFO - 'talos_options': ['--disable-e10s'], 00:55:55 INFO - 'tests': ['tp5o']}, 00:55:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:55:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:55:55 INFO - 'talos_options': ['--disable-e10s', 00:55:55 INFO - '--xperf_path', 00:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:55 INFO - 'tests': ['tp5n']}, 00:55:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:55:55 INFO - 'talos_options': ['--xperf_path', 00:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:55 INFO - 'tests': ['tp5n']}}, 00:55:55 INFO - 'talos.zip': {'path': '', 00:55:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:55:55 INFO - Running post-action listener: _resource_record_post_action 00:55:55 INFO - [mozharness: 2017-02-07 08:55:55.832092Z] Finished populate-webroot step (success) 00:55:55 INFO - [mozharness: 2017-02-07 08:55:55.832183Z] Running create-virtualenv step. 00:55:55 INFO - Running pre-action listener: _resource_record_pre_action 00:55:55 INFO - Running main action method: create_virtualenv 00:55:55 INFO - Creating virtualenv /builds/slave/test/build/venv 00:55:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:55:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:55:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:55:55 INFO - Using real prefix '/usr' 00:55:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:55:56 INFO - Installing distribute.............................................................................................................................................................................................done. 00:55:58 INFO - Installing pip.................done. 00:55:58 INFO - Return code: 0 00:55:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:55:58 INFO - Reading from file tmpfile_stdout 00:55:58 INFO - Output received: 00:55:58 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) 00:55:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:55:58 INFO - Using env: {'DISPLAY': ':0', 00:55:58 INFO - 'HOME': '/home/cltbld', 00:55:58 INFO - 'LANG': 'en_US.UTF-8', 00:55:58 INFO - 'LANGUAGE': 'en_US:en', 00:55:58 INFO - 'LOGNAME': 'cltbld', 00:55:58 INFO - 'MAIL': '/var/mail/cltbld', 00:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:58 INFO - 'MOZ_NO_REMOTE': '1', 00:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:58 INFO - 'NO_EM_RESTART': '1', 00:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:58 INFO - 'PWD': '/builds/slave/test', 00:55:58 INFO - 'SHELL': '/bin/bash', 00:55:58 INFO - 'SHLVL': '1', 00:55:58 INFO - 'TERM': 'linux', 00:55:58 INFO - 'TMOUT': '86400', 00:55:58 INFO - 'USER': 'cltbld', 00:55:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:58 INFO - '_': '/tools/buildbot/bin/python'} 00:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:55:58 INFO - Cleaning up... 00:55:58 INFO - Return code: 0 00:55:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:55:58 INFO - Using env: {'DISPLAY': ':0', 00:55:58 INFO - 'HOME': '/home/cltbld', 00:55:58 INFO - 'LANG': 'en_US.UTF-8', 00:55:58 INFO - 'LANGUAGE': 'en_US:en', 00:55:58 INFO - 'LOGNAME': 'cltbld', 00:55:58 INFO - 'MAIL': '/var/mail/cltbld', 00:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:58 INFO - 'MOZ_NO_REMOTE': '1', 00:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:58 INFO - 'NO_EM_RESTART': '1', 00:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:58 INFO - 'PWD': '/builds/slave/test', 00:55:58 INFO - 'SHELL': '/bin/bash', 00:55:58 INFO - 'SHLVL': '1', 00:55:58 INFO - 'TERM': 'linux', 00:55:58 INFO - 'TMOUT': '86400', 00:55:58 INFO - 'USER': 'cltbld', 00:55:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:58 INFO - '_': '/tools/buildbot/bin/python'} 00:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:59 INFO - Downloading/unpacking psutil>=3.1.1 00:55:59 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 00:55:59 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 00:55:59 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 00:55:59 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 00:55:59 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 00:55:59 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 00:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:56:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:01 INFO - Installing collected packages: psutil 00:56:01 INFO - Running setup.py install for psutil 00:56:01 INFO - building 'psutil._psutil_linux' extension 00:56:01 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 00:56:01 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 00:56:01 INFO - building 'psutil._psutil_posix' extension 00:56:01 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 00:56:01 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 00:56:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:01 INFO - Successfully installed psutil 00:56:01 INFO - Cleaning up... 00:56:01 INFO - Return code: 0 00:56:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:56:01 INFO - Using env: {'DISPLAY': ':0', 00:56:01 INFO - 'HOME': '/home/cltbld', 00:56:01 INFO - 'LANG': 'en_US.UTF-8', 00:56:01 INFO - 'LANGUAGE': 'en_US:en', 00:56:01 INFO - 'LOGNAME': 'cltbld', 00:56:01 INFO - 'MAIL': '/var/mail/cltbld', 00:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:01 INFO - 'MOZ_NO_REMOTE': '1', 00:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:01 INFO - 'NO_EM_RESTART': '1', 00:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:01 INFO - 'PWD': '/builds/slave/test', 00:56:01 INFO - 'SHELL': '/bin/bash', 00:56:01 INFO - 'SHLVL': '1', 00:56:01 INFO - 'TERM': 'linux', 00:56:01 INFO - 'TMOUT': '86400', 00:56:01 INFO - 'USER': 'cltbld', 00:56:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:01 INFO - '_': '/tools/buildbot/bin/python'} 00:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:56:04 INFO - Installing collected packages: mozsystemmonitor 00:56:04 INFO - Running setup.py install for mozsystemmonitor 00:56:04 INFO - Successfully installed mozsystemmonitor 00:56:04 INFO - Cleaning up... 00:56:04 INFO - Return code: 0 00:56:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:56:04 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')]} 00:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:04 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')]} 00:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:04 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 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:04 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 00:56:04 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 00:56:04 INFO - Using env: {'DISPLAY': ':0', 00:56:04 INFO - 'HOME': '/home/cltbld', 00:56:04 INFO - 'LANG': 'en_US.UTF-8', 00:56:04 INFO - 'LANGUAGE': 'en_US:en', 00:56:04 INFO - 'LOGNAME': 'cltbld', 00:56:04 INFO - 'MAIL': '/var/mail/cltbld', 00:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:04 INFO - 'MOZ_NO_REMOTE': '1', 00:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:04 INFO - 'NO_EM_RESTART': '1', 00:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:04 INFO - 'PWD': '/builds/slave/test', 00:56:04 INFO - 'SHELL': '/bin/bash', 00:56:04 INFO - 'SHLVL': '1', 00:56:04 INFO - 'TERM': 'linux', 00:56:04 INFO - 'TMOUT': '86400', 00:56:04 INFO - 'USER': 'cltbld', 00:56:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:04 INFO - '_': '/tools/buildbot/bin/python'} 00:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:04 INFO - Downloading/unpacking jsonschema==2.5.1 00:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:56:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:06 INFO - Downloading functools32-3.2.3-2.tar.gz 00:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:56:06 INFO - warning: no files found matching '*.txt' 00:56:06 INFO - no previously-included directories found matching 'build' 00:56:06 INFO - no previously-included directories found matching 'dist' 00:56:06 INFO - no previously-included directories found matching '.git*' 00:56:06 INFO - Installing collected packages: jsonschema, functools32 00:56:06 INFO - Running setup.py install for functools32 00:56:06 INFO - warning: no files found matching '*.txt' 00:56:06 INFO - no previously-included directories found matching 'build' 00:56:06 INFO - no previously-included directories found matching 'dist' 00:56:06 INFO - no previously-included directories found matching '.git*' 00:56:06 INFO - Successfully installed jsonschema functools32 00:56:06 INFO - Cleaning up... 00:56:06 INFO - Return code: 0 00:56:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:56:06 INFO - Using env: {'DISPLAY': ':0', 00:56:06 INFO - 'HOME': '/home/cltbld', 00:56:06 INFO - 'LANG': 'en_US.UTF-8', 00:56:06 INFO - 'LANGUAGE': 'en_US:en', 00:56:06 INFO - 'LOGNAME': 'cltbld', 00:56:06 INFO - 'MAIL': '/var/mail/cltbld', 00:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:06 INFO - 'MOZ_NO_REMOTE': '1', 00:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:06 INFO - 'NO_EM_RESTART': '1', 00:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:06 INFO - 'PWD': '/builds/slave/test', 00:56:06 INFO - 'SHELL': '/bin/bash', 00:56:06 INFO - 'SHLVL': '1', 00:56:06 INFO - 'TERM': 'linux', 00:56:06 INFO - 'TMOUT': '86400', 00:56:06 INFO - 'USER': 'cltbld', 00:56:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:06 INFO - '_': '/tools/buildbot/bin/python'} 00:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:56:07 INFO - Cleaning up... 00:56:07 INFO - Return code: 0 00:56:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:56: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')]} 00:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:07 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 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:07 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 00:56:07 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 00:56:07 INFO - Using env: {'DISPLAY': ':0', 00:56:07 INFO - 'HOME': '/home/cltbld', 00:56:07 INFO - 'LANG': 'en_US.UTF-8', 00:56:07 INFO - 'LANGUAGE': 'en_US:en', 00:56:07 INFO - 'LOGNAME': 'cltbld', 00:56:07 INFO - 'MAIL': '/var/mail/cltbld', 00:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:07 INFO - 'MOZ_NO_REMOTE': '1', 00:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:07 INFO - 'NO_EM_RESTART': '1', 00:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:07 INFO - 'PWD': '/builds/slave/test', 00:56:07 INFO - 'SHELL': '/bin/bash', 00:56:07 INFO - 'SHLVL': '1', 00:56:07 INFO - 'TERM': 'linux', 00:56:07 INFO - 'TMOUT': '86400', 00:56:07 INFO - 'USER': 'cltbld', 00:56:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:07 INFO - '_': '/tools/buildbot/bin/python'} 00:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:07 INFO - Downloading/unpacking blobuploader==1.2.4 00:56:07 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 00:56:07 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 00:56:07 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 00:56:07 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 00:56:07 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 00:56:07 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 00:56:09 INFO - Downloading blobuploader-1.2.4.tar.gz 00:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:56:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:56:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:10 INFO - Downloading docopt-0.6.1.tar.gz 00:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:56:10 INFO - Installing collected packages: blobuploader, requests, docopt 00:56:10 INFO - Running setup.py install for blobuploader 00:56:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:56:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:56:10 INFO - Running setup.py install for requests 00:56:10 INFO - Running setup.py install for docopt 00:56:10 INFO - Successfully installed blobuploader requests docopt 00:56:10 INFO - Cleaning up... 00:56:10 INFO - Return code: 0 00:56:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:10 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 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:10 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 00:56:10 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 00:56:10 INFO - Using env: {'DISPLAY': ':0', 00:56:10 INFO - 'HOME': '/home/cltbld', 00:56:10 INFO - 'LANG': 'en_US.UTF-8', 00:56:10 INFO - 'LANGUAGE': 'en_US:en', 00:56:10 INFO - 'LOGNAME': 'cltbld', 00:56:10 INFO - 'MAIL': '/var/mail/cltbld', 00:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:10 INFO - 'MOZ_NO_REMOTE': '1', 00:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:10 INFO - 'NO_EM_RESTART': '1', 00:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:10 INFO - 'PWD': '/builds/slave/test', 00:56:10 INFO - 'SHELL': '/bin/bash', 00:56:10 INFO - 'SHLVL': '1', 00:56:10 INFO - 'TERM': 'linux', 00:56:10 INFO - 'TMOUT': '86400', 00:56:10 INFO - 'USER': 'cltbld', 00:56:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:10 INFO - '_': '/tools/buildbot/bin/python'} 00:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:10 INFO - Running setup.py (path:/tmp/pip-_expDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:11 INFO - Running setup.py (path:/tmp/pip-5fdodF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:11 INFO - Running setup.py (path:/tmp/pip-mMwyum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:11 INFO - Running setup.py (path:/tmp/pip-mCYYMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:11 INFO - Running setup.py (path:/tmp/pip-h6tABF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:11 INFO - Running setup.py (path:/tmp/pip-PftomJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:11 INFO - Running setup.py (path:/tmp/pip-b9KJue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:11 INFO - Running setup.py (path:/tmp/pip-aNB_nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:11 INFO - Running setup.py (path:/tmp/pip-LZPnzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:11 INFO - Running setup.py (path:/tmp/pip-YjJ3gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:11 INFO - Running setup.py (path:/tmp/pip-9lhH_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:11 INFO - Running setup.py (path:/tmp/pip-WPvYTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:11 INFO - Running setup.py (path:/tmp/pip-yIUPmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:11 INFO - Running setup.py (path:/tmp/pip-Ew0nPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:11 INFO - Running setup.py (path:/tmp/pip-dgK7xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:12 INFO - Running setup.py (path:/tmp/pip-jRad_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:12 INFO - Running setup.py (path:/tmp/pip-nugUyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:56:12 INFO - Running setup.py install for manifestparser 00:56:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:56:12 INFO - Running setup.py install for mozcrash 00:56:12 INFO - Running setup.py install for mozdebug 00:56:12 INFO - Running setup.py install for mozdevice 00:56:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:56:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:56:12 INFO - Running setup.py install for mozfile 00:56:12 INFO - Running setup.py install for mozhttpd 00:56:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:56:12 INFO - Running setup.py install for mozinfo 00:56:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:56:12 INFO - Running setup.py install for mozInstall 00:56:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Running setup.py install for mozleak 00:56:13 INFO - Running setup.py install for mozlog 00:56:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Running setup.py install for moznetwork 00:56:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Running setup.py install for mozprocess 00:56:13 INFO - Running setup.py install for mozprofile 00:56:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Running setup.py install for mozrunner 00:56:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Running setup.py install for mozscreenshot 00:56:13 INFO - Running setup.py install for moztest 00:56:13 INFO - Running setup.py install for mozversion 00:56:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:56:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:56:13 INFO - Cleaning up... 00:56:14 INFO - Return code: 0 00:56:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:14 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')]} 00:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:14 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')]} 00:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:14 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 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:14 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 00:56:14 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 00:56:14 INFO - Using env: {'DISPLAY': ':0', 00:56:14 INFO - 'HOME': '/home/cltbld', 00:56:14 INFO - 'LANG': 'en_US.UTF-8', 00:56:14 INFO - 'LANGUAGE': 'en_US:en', 00:56:14 INFO - 'LOGNAME': 'cltbld', 00:56:14 INFO - 'MAIL': '/var/mail/cltbld', 00:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:14 INFO - 'MOZ_NO_REMOTE': '1', 00:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:14 INFO - 'NO_EM_RESTART': '1', 00:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:14 INFO - 'PWD': '/builds/slave/test', 00:56:14 INFO - 'SHELL': '/bin/bash', 00:56:14 INFO - 'SHLVL': '1', 00:56:14 INFO - 'TERM': 'linux', 00:56:14 INFO - 'TMOUT': '86400', 00:56:14 INFO - 'USER': 'cltbld', 00:56:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:14 INFO - '_': '/tools/buildbot/bin/python'} 00:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:14 INFO - Running setup.py (path:/tmp/pip-fyTers-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:14 INFO - Running setup.py (path:/tmp/pip-KrrBvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:14 INFO - Running setup.py (path:/tmp/pip-x9SJDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:14 INFO - Running setup.py (path:/tmp/pip-OgZOFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:14 INFO - Running setup.py (path:/tmp/pip-AyMlFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:14 INFO - Running setup.py (path:/tmp/pip-CpChp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:14 INFO - Running setup.py (path:/tmp/pip-33voRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:14 INFO - Running setup.py (path:/tmp/pip-HXx4fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:14 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)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:14 INFO - Running setup.py (path:/tmp/pip-pPIUTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:14 INFO - Running setup.py (path:/tmp/pip-pYyQoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:14 INFO - Running setup.py (path:/tmp/pip-ihSXIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:15 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)) 00:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:15 INFO - Running setup.py (path:/tmp/pip-8eqgCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:15 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)) 00:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:15 INFO - Running setup.py (path:/tmp/pip-YnROvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:15 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)) 00:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:15 INFO - Running setup.py (path:/tmp/pip-h2aiR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:15 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)) 00:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:15 INFO - Running setup.py (path:/tmp/pip-6AQ_Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:15 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)) 00:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:15 INFO - Running setup.py (path:/tmp/pip-nC322T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:15 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)) 00:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:15 INFO - Running setup.py (path:/tmp/pip-C4xfNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:15 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)) 00:56:15 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)) 00:56:15 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)) 00:56:15 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)) 00:56:15 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)) 00:56:15 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)) 00:56:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:17 INFO - Downloading blessings-1.6.tar.gz 00:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:56:17 INFO - Installing collected packages: blessings 00:56:17 INFO - Running setup.py install for blessings 00:56:17 INFO - Successfully installed blessings 00:56:17 INFO - Cleaning up... 00:56:17 INFO - Return code: 0 00:56:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:56:17 INFO - Reading from file tmpfile_stdout 00:56:17 INFO - Current package versions: 00:56:17 INFO - argparse == 1.2.1 00:56:17 INFO - blessings == 1.6 00:56:17 INFO - blobuploader == 1.2.4 00:56:17 INFO - docopt == 0.6.1 00:56:17 INFO - functools32 == 3.2.3-2 00:56:17 INFO - jsonschema == 2.5.1 00:56:17 INFO - manifestparser == 1.1 00:56:17 INFO - mozInstall == 1.12 00:56:17 INFO - mozcrash == 1.0 00:56:17 INFO - mozdebug == 0.1 00:56:17 INFO - mozdevice == 0.49 00:56:17 INFO - mozfile == 1.2 00:56:17 INFO - mozhttpd == 0.7 00:56:17 INFO - mozinfo == 0.9 00:56:17 INFO - mozleak == 0.1 00:56:17 INFO - mozlog == 3.4 00:56:17 INFO - moznetwork == 0.27 00:56:17 INFO - mozprocess == 0.24 00:56:17 INFO - mozprofile == 0.28 00:56:17 INFO - mozrunner == 6.13 00:56:17 INFO - mozscreenshot == 0.1 00:56:17 INFO - mozsystemmonitor == 0.3 00:56:17 INFO - moztest == 0.8 00:56:17 INFO - mozversion == 1.4 00:56:17 INFO - psutil == 3.1.1 00:56:17 INFO - requests == 1.2.3 00:56:17 INFO - wsgiref == 0.1.2 00:56:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56: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')]} 00:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:18 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 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:18 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 00:56:18 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 00:56:18 INFO - Using env: {'DISPLAY': ':0', 00:56:18 INFO - 'HOME': '/home/cltbld', 00:56:18 INFO - 'LANG': 'en_US.UTF-8', 00:56:18 INFO - 'LANGUAGE': 'en_US:en', 00:56:18 INFO - 'LOGNAME': 'cltbld', 00:56:18 INFO - 'MAIL': '/var/mail/cltbld', 00:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:18 INFO - 'MOZ_NO_REMOTE': '1', 00:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:18 INFO - 'NO_EM_RESTART': '1', 00:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:18 INFO - 'PWD': '/builds/slave/test', 00:56:18 INFO - 'SHELL': '/bin/bash', 00:56:18 INFO - 'SHLVL': '1', 00:56:18 INFO - 'TERM': 'linux', 00:56:18 INFO - 'TMOUT': '86400', 00:56:18 INFO - 'USER': 'cltbld', 00:56:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:18 INFO - '_': '/tools/buildbot/bin/python'} 00:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 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)) 00:56:18 INFO - Cleaning up... 00:56:18 INFO - Return code: 0 00:56:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:56:18 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')]} 00:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:18 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')]} 00:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:18 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 0x15b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1923980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, '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': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', '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 00:56:18 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 00:56:18 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 00:56:18 INFO - Using env: {'DISPLAY': ':0', 00:56:18 INFO - 'HOME': '/home/cltbld', 00:56:18 INFO - 'LANG': 'en_US.UTF-8', 00:56:18 INFO - 'LANGUAGE': 'en_US:en', 00:56:18 INFO - 'LOGNAME': 'cltbld', 00:56:18 INFO - 'MAIL': '/var/mail/cltbld', 00:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:18 INFO - 'MOZ_NO_REMOTE': '1', 00:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:18 INFO - 'NO_EM_RESTART': '1', 00:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:18 INFO - 'PWD': '/builds/slave/test', 00:56:18 INFO - 'SHELL': '/bin/bash', 00:56:18 INFO - 'SHLVL': '1', 00:56:18 INFO - 'TERM': 'linux', 00:56:18 INFO - 'TMOUT': '86400', 00:56:18 INFO - 'USER': 'cltbld', 00:56:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:18 INFO - '_': '/tools/buildbot/bin/python'} 00:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:56:18 INFO - Cleaning up... 00:56:18 INFO - Return code: 0 00:56:18 INFO - Running post-action listener: _resource_record_post_action 00:56:18 INFO - Running post-action listener: _start_resource_monitoring 00:56:18 INFO - Starting resource monitoring. 00:56:18 INFO - [mozharness: 2017-02-07 08:56:18.486466Z] Finished create-virtualenv step (success) 00:56:18 INFO - [mozharness: 2017-02-07 08:56:18.486957Z] Running install step. 00:56:18 INFO - Running pre-action listener: _resource_record_pre_action 00:56:18 INFO - Running main action method: install 00:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:56:18 INFO - Reading from file tmpfile_stdout 00:56:18 INFO - Detecting whether we're running mozinstall >=1.0... 00:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:56:18 INFO - Reading from file tmpfile_stdout 00:56:18 INFO - Output received: 00:56:18 INFO - Usage: mozinstall [options] installer 00:56:18 INFO - Options: 00:56:18 INFO - -h, --help show this help message and exit 00:56:18 INFO - -d DEST, --destination=DEST 00:56:18 INFO - Directory to install application into. [default: 00:56:18 INFO - "/builds/slave/test"] 00:56:18 INFO - --app=APP Application being installed. [default: firefox] 00:56:18 INFO - mkdir: /builds/slave/test/build/application 00:56:18 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'] 00:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:56:35 INFO - Reading from file tmpfile_stdout 00:56:35 INFO - Output received: 00:56:35 INFO - /builds/slave/test/build/application/firefox/firefox 00:56:35 INFO - Running post-action listener: _resource_record_post_action 00:56:35 INFO - [mozharness: 2017-02-07 08:56:35.948516Z] Finished install step (success) 00:56:35 INFO - [mozharness: 2017-02-07 08:56:35.948788Z] Running run-tests step. 00:56:35 INFO - Running pre-action listener: _resource_record_pre_action 00:56:35 INFO - Running main action method: run_tests 00:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:56:35 INFO - Python 2.7.3 00:56:35 INFO - Return code: 0 00:56:35 INFO - grabbing minidump binary from tooltool 00:56:35 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')]} 00:56:35 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 0x1920d00>, '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 0x1921a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1921eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:56:35 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 00:56:35 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 00:56:35 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 00:56:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:56:36 INFO - Return code: 0 00:56:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:56:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:56:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:56:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:56:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 00:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 00:56:36 INFO - Using env: {'DISPLAY': ':0', 00:56:36 INFO - 'HOME': '/home/cltbld', 00:56:36 INFO - 'LANG': 'en_US.UTF-8', 00:56:36 INFO - 'LANGUAGE': 'en_US:en', 00:56:36 INFO - 'LOGNAME': 'cltbld', 00:56:36 INFO - 'MAIL': '/var/mail/cltbld', 00:56:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:56:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:36 INFO - 'MOZ_NO_REMOTE': '1', 00:56:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:36 INFO - 'NO_EM_RESTART': '1', 00:56:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:36 INFO - 'PWD': '/builds/slave/test', 00:56:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:56:36 INFO - 'SHELL': '/bin/bash', 00:56:36 INFO - 'SHLVL': '1', 00:56:36 INFO - 'TERM': 'linux', 00:56:36 INFO - 'TMOUT': '86400', 00:56:36 INFO - 'USER': 'cltbld', 00:56:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092', 00:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:36 INFO - '_': '/tools/buildbot/bin/python'} 00:56:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 00:56:36 INFO - mozversion application_buildid: 20170207075830 00:56:36 INFO - mozversion application_changeset: 4116e3e124601c356950880ad01f015626b21345 00:56:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:56:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:56:36 INFO - mozversion application_name: Firefox 00:56:36 INFO - mozversion application_remotingname: firefox-dev 00:56:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:56:36 INFO - mozversion application_vendor: Mozilla 00:56:36 INFO - mozversion application_version: 53.0a2 00:56:36 INFO - mozversion platform_buildid: 20170207075830 00:56:36 INFO - mozversion platform_changeset: 4116e3e124601c356950880ad01f015626b21345 00:56:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:56:36 INFO - mozversion platform_version: 53.0a2 00:56:36 INFO - using testdate: 1486457796 00:56:36 INFO - actual date: 1486457796 00:56:36 INFO - starting webserver on 'localhost:51333' 00:56:36 INFO - SUITE-START | Running 2 tests 00:56:36 INFO - TEST-START | dromaeo_css 00:56:36 INFO - operating with platform_type : linux_ 00:56:36 INFO - Initialising browser for dromaeo_css test... 00:56:36 INFO - TEST-INFO | started process 13067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJxR_X/profile http://localhost:51333/getInfo.html) 00:56:40 INFO - PROCESS | 13067 | __metrics Screen width/height:1600/1200 00:56:40 INFO - PROCESS | 13067 | colorDepth:24 00:56:40 INFO - PROCESS | 13067 | Browser inner width/height: 1024/697 00:56:40 INFO - PROCESS | 13067 | __metrics 00:56:40 INFO - PROCESS | 13067 | 1486457800833 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/tmpmJxR_X/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpmJxR_X/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpmJxR_X/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpmJxR_X/profile/extensions/talos-powers@TalosPowersService.js:55:9 00:56:40 ERROR - PROCESS | 13067 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 00:56:41 INFO - TEST-INFO | 13067: exit 0 00:56:41 INFO - Browser initialized. 00:56:41 INFO - Running cycle 1/1 for dromaeo_css test... 00:56:41 INFO - TEST-INFO | started process 13196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJxR_X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:56:53 INFO - PROCESS | 13196 | RSS: Main: 144859136 00:56:53 INFO - PROCESS | 13196 | 00:59:52 INFO - PROCESS | 13196 | Cycle 1(1): loaded http://localhost:51333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51333/tests/dromaeo/cssquery-ext.html) 00:59:53 INFO - PROCESS | 13196 | RSS: Main: 152690688 00:59:53 INFO - PROCESS | 13196 | 01:01:42 INFO - PROCESS | 13196 | ************************* 01:01:42 INFO - PROCESS | 13196 | A coding exception was thrown and uncaught in a Task. 01:01:42 INFO - PROCESS | 13196 | 01:01:42 ERROR - PROCESS | 13196 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:01:42 INFO - PROCESS | 13196 | Full stack: 01:01:42 INFO - PROCESS | 13196 | ************************* 01:02:55 INFO - PROCESS | 13196 | Cycle 1(1): loaded http://localhost:51333/tests/dromaeo/cssquery-ext.html (next: http://localhost:51333/tests/dromaeo/cssquery-jquery.html) 01:02:56 INFO - PROCESS | 13196 | RSS: Main: 152072192 01:02:56 INFO - PROCESS | 13196 | 01:05:58 INFO - PROCESS | 13196 | Cycle 1(1): loaded http://localhost:51333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51333/tests/dromaeo/cssquery-mootools.html) 01:05:58 INFO - PROCESS | 13196 | RSS: Main: 154451968 01:05:58 INFO - PROCESS | 13196 | 01:09:00 INFO - PROCESS | 13196 | Cycle 1(1): loaded http://localhost:51333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51333/tests/dromaeo/cssquery-prototype.html) 01:09:01 INFO - PROCESS | 13196 | RSS: Main: 152158208 01:09:01 INFO - PROCESS | 13196 | 01:12:03 INFO - PROCESS | 13196 | Cycle 1(1): loaded http://localhost:51333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51333/tests/dromaeo/cssquery-yui.html) 01:12:04 INFO - PROCESS | 13196 | RSS: Main: 153481216 01:12:04 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | Cycle 1(1): loaded http://localhost:51333/tests/dromaeo/cssquery-yui.html (next: http://localhost:51333/tests/dromaeo/cssquery-dojo.html) 01:15:06 INFO - PROCESS | 13196 | RSS: Main: 156086272 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | __start_tp_report 01:15:06 INFO - PROCESS | 13196 | _x_x_mozilla_page_load 01:15:06 INFO - PROCESS | 13196 | _x_x_mozilla_page_load_details 01:15:06 INFO - PROCESS | 13196 | |i|pagename|runs| 01:15:06 INFO - PROCESS | 13196 | |0;dojo.html;3230.628477725062;3241.1897025743565;3263.592050993626;3297.950530742041;3307.685769851864;5375.784968601256;5428.348598168215;5438.673679579223;5455.454454554542;5473.397926228112;5478.890422191554;5511.255980442639;5529.612927095095;5538.584606154544;5554.888902221953;4903.8774030649165;4931.038447502739;4986.700797952117;4998.300237966688;5008.4240312364;4960.032793605248;4963.106640804672;4993.076280888029;5003.824866129687;5024.095662780698;4786.401699787527;4797.9760101199445;4955;4960.206366981283;4978.327925730035;4881.975590122044;4884.267359896026;4920.040592084545;4953.851384458472;5017.247412888059;4939.0121975605025;4948.084604348207;4949.455559888409;4958.752062396866;4984.626153038536;5454.4545545445535;5468.699221542814;5485.780568777244;5549.1676248562635;5555.583331250173;5690.487856092972;5722.456366645204;5739.311282646109;5762.654240745569;5787.594868359217;5886.3230728465915;5893.263342082239;5900.97049514754;5901.940980590225;5938.2280303560265;5490.917636235459;5493.121100623881;5493.478119578634;5498;5500.944990550123;5794.652320860678;5819.679917604488;5880.2943646761805;5916;5935.7625694972585;5716.399778023331;5745.052066408995;5761.251037365116;5802.100674395476;5804.100364443518;5776.56675749312;5805.129230615442;5827.970860145672;5829.912551311733;5868.178455016301;5715.257016587817;5764.337101233328;5767.336756272998;5826.0678291474005;5845.181674565564;5795.449432303924;5895.4399332063385;5901.881962360729;5910.704464776744;5935.643861368331;4494.37078808967;4504.009117994036;4506.211413002777;4511.684182107287;4537.069900670354;3954.6638535724787;3958.604139586076;3961.088949541622;4013.8996525086523;4059.3099173140045;5704.600677952503;5763.423657634203;5769.48074673273;5797.246357973437;5809.244798176294;5828.271466066742;5897.32180799205;5933.406659334119;5934.109883517421;5948.9702551487835;5595.132754423071;5609.607327487037;5634.6337488063145;5752.971235143881;5766.077427611562;4964.90070198594;5006.199008158677;5011.07295150391;5026.673266237683;5030.220315851049;6013.639181649028;6055.152278680988;6079.05774604937;6084.056971169476;6091.939080609137;5688.516476099578;5713.342965558848;5867.911981320369;5870.295564532284;5870.354261031198;6037.0642550404755;6058.818235452944;6065.090236464565;6102.816915492543;6138.232720909887;5750.194972703741;5774.249347584787;5801.245838041028;5804.158397032322;5811.941880581309;5664.886702266014;5825.533957283492;5828.271466066742;5832.183494310715;5844.94155058444;5524.14375771756;5649.915251271152;5674.262345895172;5716.628419152742;5825.854353641193;5700.914486282626;5712.428757124254;5713.371529131709;5723.170140329712;5748.993926063006;5675.091985282335;5744.712764361681;5757.3954734753925;5764.654120752768;5767.826965191051;5477.1510415885605;5528.75120619565;5640.661560306395;5667.036603777286;5699.572532060195;5591.329040515164;5617.550595952396;5633.774649013993;5640.492355688008;5668.886622267449 01:15:06 INFO - PROCESS | 13196 | |1;ext.html;593.8010766393259;612.6324205476714;619.869827336259;623.4638211138421;646.7122130651856;46964.295535566955;48283.275750863766;48410;51626;52011.47988520114;50111.49888501123;50357;50803.491965080335;50810;51106.23340649893;9183.173514383687;9392.7651808705;9409.341346105775;9414.152726254635;10745.946270268638;10655.84016239757;10941.070009049241;10980.450977451135;11002.394868282241;11006.394648294341;11049.668509944675;11057.723556911062;11092.500837462294;11101.666949991513;11130.666080017612;10998.945005275002;11025.173112016631;11033.227674062819;11088.33469991795;11118.277311974696;11007.174461915389;11016.228863979524;11047.779044419147;11065.557377704883;11067;41709.58290417087;42279.365809512885;42341.36487952683;42385.36421953673;42476.78761606203;4464.107178564268;4489.932651010237;4505.481869584974;4510.774461276923;4633.837815676435;31552.368952620818;32262;32564.6743532564;32711.6728832711;32845.17887052819;4650.558196971282;4651.023285110131;4664.043871006435;4701.882452938669;4704.388429504143;378900;379452;381720;382504;385413;61426;62208;62247.377526225064;62306.37693623006;62314.376856230854;65047.67476162589;65158.67420662866;65299.34700652933;65424.345756542774;65895.34104658892;19210.327638532584;19375.806241937684;19531.609367812565;19547.8045219546;19570.412887613395;14661.193634350213;14942.178180200193;15288.235588220545;15471.071735695894;15830.129342886252;20360.49098772513;20652.896735516526;20678.379648610568;20687.8965605174;20746.79253207479;7336.413086953031;7352.705891764376;7365.852682946311;7518.736844210426;7523.210062943422;994.4381424495137;1010.7068950004564;1038.413296487482;1038.963636272742;1054.9683509494728;34342.82828585891;34417.13957151091;34688;34887;35236.00493957991;1157.3171828621155;1168.8597368315857;1172.2204733852063;1174.2426135142784;1181.3207405741732;15938.840611593967;15967.760483592756;16024.679506409806;16143.838561614233;16291.42979995718;510711;512053;513956;515901;523901;60655.39344606586;60928.390716093156;61252;61322.38677613256;61343.07985380223;1554.9067055976677;1565.4833904811385;1573.0404453283488;1593.9043657380826;1601.5755824706462;29544;30396.088117356514;31192.376152477278;31333.686663133078;32528.186795330304;60462.09306860489;60988.39011609827;61291.08063379142;61339;61388.38611613827;483415;487413;488941;489092;491400;43077.35383969306;43626;44905.32642010307;44963.775181125195;45074;47782.76108619435;47836.760816195696;48176.27735583899;48623.75688121537;49627;40689;42722.786386069114;42882.35676464793;42910.356344655476;43220.351694725236;39692.60307397004;41403.378949316386;41888;42218.57781422146;42270.50980158371;40535.18929621332;40940.1811963765;41339.7933010333;42129;42132.78933605312;35336.46995295021;35359.646403536666;36018.09954751152;36640.26719465649;36903;28096.43807123887;28707.282317941383;28819.855900720362;28928.276793080342;29039 01:15:06 INFO - PROCESS | 13196 | |2;jquery.html;434.19890302392093;439.0604107210569;439.3300217168819;443.200023956758;446.38408959566357;20723.378298651045;21699.240526581572;22065.227717029906;22200.888995555;22481.775182248173;20491;22198.445038874037;22832.65751013736;22879.656805147937;22983.42541436465;5944.464998150165;5963.910541341883;6162.291336496293;6169.10547970544;6169.907451388232;5842.269716285465;5957.910631340534;5991.490723288504;5998.610090344114;6006.609570377911;5805.36141024487;5853.531717462614;5941.910871336933;5942.049272116462;5947.851303717398;5838.854028649296;5895.911561326584;5905.468507834273;5923.466887980081;5930.229070220887;5220.582353411718;5241.187615919539;5243.737813109329;5255.86860328491;5321.095413779667;24910.626340604904;24961;24998.625020624706;25280.620790688154;25291.494170116493;3401.6258211596705;3412.5904891412943;3418.077119177833;3434.1242983039415;3466.878659246914;14791.630209244748;15010.324535395934;15013.849861501354;15557.611059723484;15656.138912359816;2009.718639390472;2058.5059585699323;2103.5897999890026;2217.634090375086;2251.0883092347626;97389.513052435;98293.50853245688;99010.50494747552;99571;101217;12337.814932776015;12341.3829308536;12416.503339866485;12502.624501344715;12528.749425011449;18092.638147236983;18094.095295235187;18106.45680629583;18183.818161818213;18185.909070454563;8914.910850891538;8967.865482017774;8990.235829954396;9085.636574537077;9153.77115572116;8482.491050536988;8611.354148438892;8634.525101119372;8805.603747831236;8820.206181443573;5185.7407129644125;5297.417284098746;5382.300300960928;5435.10320797064;5458.426865179099;2089.529855782467;2145.903434345458;2167.8048975592274;2196.341097670724;2201.669749537582;1119.160629527854;1140.2417392434104;1142.6343570057668;1161.4715304536417;1164.8136298192248;20520.58958820845;20574.485637858874;20606.381808545768;20635.17459301641;20690.793092069187;1170.0347213548857;1183.1067544004393;1197.8921897029309;1204.1631066408936;1208.2146604706836;11372.203945723886;11417.942910285561;11509.597164099216;11514.194006419637;11525;657866;676618;699445;748795;774281;95634;99696;110859;117929;123852;521.2025600830735;543.5515699547889;544.2978557660653;545.6753231827057;547.8630342414397;11646.24299420535;12024.879751202727;12139.57511487129;12167.57413490559;12415.193012454161;41000.17999639931;41105.79447102745;41700;46449.53550464452;47442.52557474381;56993.43006570047;68137.65931170313;68746;68895.96656050063;69205.3079469219;9211.355205135576;9403.717888463358;9544.236461082957;9652.66215682476;9821.558029888814;8011.719589814328;12680.668529804238;14339.211343376215;14967.77548336754;15003.324850381978;12031;12281.263124212219;12333.471638314304;12453.315067671365;12847.678808029501;12304.938475307566;12360.75278494407;12510.937445313079;12570.057245706792;12641.557545485864;12414.317212553397;12555.560555380518;12725.236485810881;12747.936260318638;12903;9681.757956051155;9811.411315321104;9914.256430767577;9933.255005874444;10014.749631259278;11957.222780519587;12536.874631253935;12612.684682882635;12630.936845315715;12644.936775316064 01:15:06 INFO - PROCESS | 13196 | |3;mootools.html;1478.17222355481;1506.2920427399122;1511.5692027772084;1515.969680606388;1520.6654536002075;8243.505389676617;8500.61747221375;8768.649254029839;8784.1655042771;8893.777655558615;8530.658773649062;8609.182127697859;8692;8700.173483519071;8707.434016788904;2447.608382658775;2468.1731619907355;2484.3043947694673;2492.3395300245447;2493.7381574934643;2414.7343792182846;2459.8401103928277;2476.9752302477013;2480.355107672009;2482.156066937241;2432.1609044879488;2457.1154384421593;2466.075221791828;2475.2450502596703;2480.454300053985;2393.8324317297797;2396.209250947183;2398.484325869929;2408.036785285882;2430.149447693311;2366.349253955159;2386.4869053153484;2401.2916189724074;2418.03278688526;2419.358869899478;8791.81310523084;8796.780080497974;8819;8819.250363719091;8868.911310886873;5315.893682126374;5442.374126975409;5446.2375267462585;5450.400455949843;5457.699826509541;3502.176988407722;3554.4668299755244;3573.94639080414;3618.475321078455;3651.5070465487083;1366.5422083602004;1368.8288963879515;1398.923059231752;1419.332913530639;1467.4790449390525;10879.347239165596;11396.943015284953;11541.711457213636;11664.591739289084;11895.107866910017;4680.81276748933;4752.881177970509;4765.213739732974;4919.704817710949;4948.901021979612;10234.130098941674;10234.6417875374;10247.975202479842;10287.22845786569;10306.845397319046;5415.0523658359625;5458.4814442627885;5479.945200547943;5482.342118945752;5488.4785945335125;4910.631702622318;5058.3929928408825;5060.139776238048;5130.846074617767;5199.766010529535;3897.025743564109;3956.2680904032845;3969.980150099231;4009.1380353223612;4066;1165.1319766773809;1171.308927732642;1181.9586314478952;1182.3910685996718;1193.3794426897964;1006.3106771861152;1019.6838979916249;1022.4836457589018;1033.705393962717;1035.4615599888016;5901.40985901415;5912.793052243151;5984.640921544721;6032.939670603326;6190.876182476325;1047.146575540947;1081.3998230981724;1086.1093902999464;1101.2126329674322;1138.6811692725885;3967.2858885400906;4146.66826653867;4166.58334166587;4169.812358443877;4246.8725938221905;9988.750281243027;10279.486025698685;10304.330218535772;10358.378497290187;10394.584216631401;10096.798064038678;10205.336653117523;10244;10316.071553560216;10332.638357657446;8047.718329858544;8119.959400202961;8248.793780155424;8250.339972802161;8279;5540.335159780852;5603;5622;5672.60291779588;5739.110437882135;9320.906790932004;9567.856482152634;9602.375845570015;9631.133198012212;9681.467519286225;9094.136057074567;9467.621295148392;9517.23862091045;9588.90411095908;9671.226301895973;7441.888371674538;7613.200613935457;7700.229977002479;7781.26078022587;7949.085855126503;8377;8401.117882622237;8424.873626895478;8479.533625650649;8486.702965396182;7239.963800181176;7266.346028857428;7290.270972902667;7319.048523691886;7570.5836179010685;6902.8619427612175;6908.654567271717;6945.0971373721095;6960.721571137098;6974.79075627732;6764.526483146133;6823.658817059227;6856.794296171123;6864.24493305726;6875.1749790025515;5216.347956505437;5243;5246.475352464723;5266.605004624592;5413.215083812746;5130.692158470503;5143.254228136974;5183.740812959412;5208;5330.54690351309 01:15:06 INFO - PROCESS | 13196 | |4;prototype.html;403.2237941961723;412.11395499675695;415.0868090201556;425.6211971345502;429.5682838747061;5338.546223571001;5485.61600687952;5488.710153114015;5542.806001789938;5590.66456012639;5284.44513326101;5417.864553386167;5437.667771396003;5479.424660410659;5481.780728770845;4383.356241409471;4393.340998850182;4397.824087036514;4412.536683648219;4414.602685758281;4352.695311328208;4375.496817865938;4410;4421.292593185091;4459.375687403766;4332.935005974913;4340.348947657845;4341.891452713691;4357.368181613664;4363.650907927374;4332.155229730204;4333.263345231302;4346.3915051892445;4371.256886329332;4393.143337049277;3902.7072969527117;4030.6775457963295;4043.6562892153906;4047.0978640039134;4063.349864021742;5326.7070311132875;5351.518363347317;5425.256572964642;5444.6188766786345;5447.509724124809;5123.436421993578;5126.410462796789;5139.537441630271;5144.4083930348115;5166.870828229286;5576.247206627094;5773.595848290622;5788.450097240798;5791.971040144815;5854.268216472941;4489.708168969007;4494.415725955638;4497.820087196508;4498.190325741365;4512.503624601291;5953.3451320354725;5979.521638268971;5999.220101386792;6015.789447369365;6016.465801220748;4362.9781851091175;4525.551823416541;4557.339185818038;4642.442906851199;4646.86059418218;4652.441706995182;4654.790534425959;4657.534246575383;4663.603593694574;4663.743494107789;5129.846104616868;5154.639175257696;5163.3545806774155;5163.432022477525;5169.457206993212;5690.630109042899;5765.538756899438;5780.942190578125;5826.261657021193;5837.474627283565;1499.5651261134149;1568.4588816858166;1570.4503423801577;1572.1448690545267;1582.596437908326;1113.5768408005067;1130.3613458396144;1133.9489722962487;1147.2198904744853;1150.183369807446;5537.6954267515675;5575.386707462176;5604.551635869121;5613.971930140323;5620.185073164368;5616.213730077792;5751.396103409165;5751.8562035949435;5777.215923570068;5789.3921138279875;5466.617336786467;5524.447555244444;5531.723413829292;5533.1976863354585;5589.357223919302;3028.394321135782;3036.5596988436555;3038.878444862225;3048.7103725146076;3079.969200308013;5770.596058275964;5832.300123985149;5935.762569497172;5983.222181116514;5984.012637914782;5776.537876969833;5787.305523337226;5805.274340707411;5820.933568583092;5838.357780644125;5876;5910.438508341701;5930.28836539618;5947.86990471809;5987.880242395127;5424.728763561727;5669.744861481326;5677.3471050829685;5691.971540142438;5704.3154821421695;5636.774529018793;5649.71751412436;5659.075914189196;5661.631993920382;5708.343540492897;5845;5908.763649453974;5910;5974.492168165581;5983.14522498027;4245.596668316505;4331.198728235287;4335.1979883721615;4337.3927650129635;4349.521552629271;5815.912761308499;5834.38738932406;5947.910781338197;5958.702064896825;5993.9700301498215;5716.628419152742;5765.192872997867;5774.335951365647;5786.508146807569;5794.246747922743;5748.971255143698;5778.8266352009505;5801.245838041196;5801.622894511843;5830.795922142875;5639.88720225585;5763.135529670583;5765.452282033368;5794.565407594363;5803.274590676166;5787.768489260382;5801.274840644919;5814.186013957965;5847.181394604674;5862.355140934408;5494.175873618829;5601.383847776659;5648.540777023116;5723.599348045597;5754.165645981393 01:15:06 INFO - PROCESS | 13196 | |5;yui.html;818.9845584184166;840.6595328891793;851.5529347092779;915.2860768600492;937.9812403751926;15699.843001569981;15966.521004369888;16277.348906043773;16729.414470493535;16747.16264186789;16293.266802993865;16516.25676844542;16566.83433165668;16675.916620416912;16901.57746056349;817.7505860712465;818.6193420059672;830.1615368477851;831.787894087007;832.1304237072244;797.5892415406071;844.0167205205928;844.9155084491563;848.3764433141666;853.5774791478227;875.2560323724847;878.086789738671;878.2359347367799;881.6164968238804;882.4881568690176;865.5455885660048;868.5700578213794;874.5627186406797;874.654511467973;875.711015364928;641.8972964325685;644.3041515163659;644.4779728419995;644.9903251451232;646.5215740352153;14778.852211477855;14981.850181498263;17197.968121912727;17725.202365893438;17816.46550603484;14542;15730.68538629221;16052.357905683759;16088.517344479684;16409.343626254937;12868.806967895489;12927.418266178045;13046.282454465001;13073.411696473682;13177.209367437985;4804.0872234275375;4813.831515896927;4872.902541949176;4896.290037944478;4912.7297998610065;86545;87424.12575874223;88018.55990720005;88427;88917.55541222253;12067.456964436622;12499.999999999978;12547.121701480992;12596.55912043074;12599;21259.192968597843;22705.091796328292;22866.199683011346;22984.195553155558;23269.138468922447;8832.5583720815;8908.599113039929;8916.331275154389;9020.323475739215;9077.863832042525;4439.872379759666;4442.511323754385;4471.977640111779;4511.932321015187;4584.862454126382;3711.5175027246823;3727.086863718352;3760.1539653578275;3786.1291902862495;3786.962130378716;627.6296984778911;631.6620607974711;641.0416427441005;647.2233320015999;653.8855700252532;782.24122601078;782.4913806026128;790.715342476708;807.5033854179637;816.5590581086266;10417;10751.462426878781;10836;10844.349339039683;11011;782.7769085810517;788.8501184774874;820.5404973215019;828.0518805967254;840.920112589303;4963.851084467472;5117.744112794346;5125.615578831528;5148.536631703165;5153.974230128825;63260.36739632545;73883;83291;87403.56298218468;87906;72579.63710181415;73490.63254683692;74058.62970685112;74725.25274747182;75450;67983.32016679869;68159.31840681529;68181.31818681849;68935;70235.29764702288;10793.40636265013;11528.532270122103;11625.6512304631;12119.878801211875;12189.146759726735;42349.36475952801;43035.139297214504;43100.353494696974;43275.78362108169;43383.13233735244;58794;58808;59790.10314845194;60908.69545652244;61959.38040619536;13534.864651353755;13832.239226842621;13848.427063885802;13927.373268202753;13950.79073813914;16236.67526649484;16271.67456650884;16284.51146465608;16761.832381676028;17335.873168244023;15289.541313760605;15424.383024678888;15765;15798.684026319639;16225.269862855963;14155.504557340444;14205.28973551339;14383.065100768417;14508.564743057725;14744.705105897607;14895.004954710443;15073.246337682853;15251.466198682992;15320.46378376796;15529.145896975775;12191.878081219074;12213.511459541518;12440.502379904703;12624.17942833713;12967.41646625923;12371.443285052013;12523.624291271277;12662.430190641258;12695.682607934876;12711.110222284351 01:15:06 INFO - PROCESS | 13196 | __end_tp_report 01:15:06 INFO - PROCESS | 13196 | __start_cc_report 01:15:06 INFO - PROCESS | 13196 | _x_x_mozilla_cycle_collect,305 01:15:06 INFO - PROCESS | 13196 | __end_cc_report 01:15:06 INFO - PROCESS | 13196 | __startTimestamp1486458906800__endTimestamp 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | ------- Summary: start ------- 01:15:06 INFO - PROCESS | 13196 | Number of tests: 6 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | [#0] dojo.html Cycles:165 Average:5439.34 Median:5688.52 stddev:607.04 (10.7%) stddev-sans-first:583.65 01:15:06 INFO - PROCESS | 13196 | Values: 3230.6 3241.2 3263.6 3298.0 3307.7 5375.8 5428.3 5438.7 5455.5 5473.4 5478.9 5511.3 5529.6 5538.6 5554.9 4903.9 4931.0 4986.7 4998.3 5008.4 4960.0 4963.1 4993.1 5003.8 5024.1 4786.4 4798.0 4955.0 4960.2 4978.3 4882.0 4884.3 4920.0 4953.9 5017.2 4939.0 4948.1 4949.5 4958.8 4984.6 5454.5 5468.7 5485.8 5549.2 5555.6 5690.5 5722.5 5739.3 5762.7 5787.6 5886.3 5893.3 5901.0 5901.9 5938.2 5490.9 5493.1 5493.5 5498.0 5500.9 5794.7 5819.7 5880.3 5916.0 5935.8 5716.4 5745.1 5761.3 5802.1 5804.1 5776.6 5805.1 5828.0 5829.9 5868.2 5715.3 5764.3 5767.3 5826.1 5845.2 5795.4 5895.4 5901.9 5910.7 5935.6 4494.4 4504.0 4506.2 4511.7 4537.1 3954.7 3958.6 3961.1 4013.9 4059.3 5704.6 5763.4 5769.5 5797.2 5809.2 5828.3 5897.3 5933.4 5934.1 5949.0 5595.1 5609.6 5634.6 5753.0 5766.1 4964.9 5006.2 5011.1 5026.7 5030.2 6013.6 6055.2 6079.1 6084.1 6091.9 5688.5 5713.3 5867.9 5870.3 5870.4 6037.1 6058.8 6065.1 6102.8 6138.2 5750.2 5774.2 5801.2 5804.2 5811.9 5664.9 5825.5 5828.3 5832.2 5844.9 5524.1 5649.9 5674.3 5716.6 5825.9 5700.9 5712.4 5713.4 5723.2 5749.0 5675.1 5744.7 5757.4 5764.7 5767.8 5477.2 5528.8 5640.7 5667.0 5699.6 5591.3 5617.6 5633.8 5640.5 5668.9 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | [#1] ext.html Cycles:180 Average:64002.03 Median:41556.48 stddev:122950.71 (295.9%) stddev-sans-first:123203.44 01:15:06 INFO - PROCESS | 13196 | Values: 593.8 612.6 619.9 623.5 646.7 46964.3 48283.3 48410.0 51626.0 52011.5 50111.5 50357.0 50803.5 50810.0 51106.2 9183.2 9392.8 9409.3 9414.2 10745.9 10655.8 10941.1 10980.5 11002.4 11006.4 11049.7 11057.7 11092.5 11101.7 11130.7 10998.9 11025.2 11033.2 11088.3 11118.3 11007.2 11016.2 11047.8 11065.6 11067.0 41709.6 42279.4 42341.4 42385.4 42476.8 4464.1 4489.9 4505.5 4510.8 4633.8 31552.4 32262.0 32564.7 32711.7 32845.2 4650.6 4651.0 4664.0 4701.9 4704.4 378900.0 379452.0 381720.0 382504.0 385413.0 61426.0 62208.0 62247.4 62306.4 62314.4 65047.7 65158.7 65299.3 65424.3 65895.3 19210.3 19375.8 19531.6 19547.8 19570.4 14661.2 14942.2 15288.2 15471.1 15830.1 20360.5 20652.9 20678.4 20687.9 20746.8 7336.4 7352.7 7365.9 7518.7 7523.2 994.4 1010.7 1038.4 1039.0 1055.0 34342.8 34417.1 34688.0 34887.0 35236.0 1157.3 1168.9 1172.2 1174.2 1181.3 15938.8 15967.8 16024.7 16143.8 16291.4 510711.0 512053.0 513956.0 515901.0 523901.0 60655.4 60928.4 61252.0 61322.4 61343.1 1554.9 1565.5 1573.0 1593.9 1601.6 29544.0 30396.1 31192.4 31333.7 32528.2 60462.1 60988.4 61291.1 61339.0 61388.4 483415.0 487413.0 488941.0 489092.0 491400.0 43077.4 43626.0 44905.3 44963.8 45074.0 47782.8 47836.8 48176.3 48623.8 49627.0 40689.0 42722.8 42882.4 42910.4 43220.4 39692.6 41403.4 41888.0 42218.6 42270.5 40535.2 40940.2 41339.8 42129.0 42132.8 35336.5 35359.6 36018.1 36640.3 36903.0 28096.4 28707.3 28819.9 28928.3 29039.0 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | [#2] jquery.html Cycles:180 Average:37075.76 Median:24979.81 stddev:117133.95 (468.9%) stddev-sans-first:117430.23 01:15:06 INFO - PROCESS | 13196 | Values: 434.2 439.1 439.3 443.2 446.4 20723.4 21699.2 22065.2 22200.9 22481.8 20491.0 22198.4 22832.7 22879.7 22983.4 5944.5 5963.9 6162.3 6169.1 6169.9 5842.3 5957.9 5991.5 5998.6 6006.6 5805.4 5853.5 5941.9 5942.0 5947.9 5838.9 5895.9 5905.5 5923.5 5930.2 5220.6 5241.2 5243.7 5255.9 5321.1 24910.6 24961.0 24998.6 25280.6 25291.5 3401.6 3412.6 3418.1 3434.1 3466.9 14791.6 15010.3 15013.8 15557.6 15656.1 2009.7 2058.5 2103.6 2217.6 2251.1 97389.5 98293.5 99010.5 99571.0 101217.0 12337.8 12341.4 12416.5 12502.6 12528.7 18092.6 18094.1 18106.5 18183.8 18185.9 8914.9 8967.9 8990.2 9085.6 9153.8 8482.5 8611.4 8634.5 8805.6 8820.2 5185.7 5297.4 5382.3 5435.1 5458.4 2089.5 2145.9 2167.8 2196.3 2201.7 1119.2 1140.2 1142.6 1161.5 1164.8 20520.6 20574.5 20606.4 20635.2 20690.8 1170.0 1183.1 1197.9 1204.2 1208.2 11372.2 11417.9 11509.6 11514.2 11525.0 657866.0 676618.0 699445.0 748795.0 774281.0 95634.0 99696.0 110859.0 117929.0 123852.0 521.2 543.6 544.3 545.7 547.9 11646.2 12024.9 12139.6 12167.6 12415.2 41000.2 41105.8 41700.0 46449.5 47442.5 56993.4 68137.7 68746.0 68896.0 69205.3 9211.4 9403.7 9544.2 9652.7 9821.6 8011.7 12680.7 14339.2 14967.8 15003.3 12031.0 12281.3 12333.5 12453.3 12847.7 12304.9 12360.8 12510.9 12570.1 12641.6 12414.3 12555.6 12725.2 12747.9 12903.0 9681.8 9811.4 9914.3 9933.3 10014.7 11957.2 12536.9 12612.7 12630.9 12644.9 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | [#3] mootools.html Cycles:180 Average:5716.85 Median:5059.27 stddev:3080.53 (60.9%) stddev-sans-first:3072.70 01:15:06 INFO - PROCESS | 13196 | Values: 1478.2 1506.3 1511.6 1516.0 1520.7 8243.5 8500.6 8768.6 8784.2 8893.8 8530.7 8609.2 8692.0 8700.2 8707.4 2447.6 2468.2 2484.3 2492.3 2493.7 2414.7 2459.8 2477.0 2480.4 2482.2 2432.2 2457.1 2466.1 2475.2 2480.5 2393.8 2396.2 2398.5 2408.0 2430.1 2366.3 2386.5 2401.3 2418.0 2419.4 8791.8 8796.8 8819.0 8819.3 8868.9 5315.9 5442.4 5446.2 5450.4 5457.7 3502.2 3554.5 3573.9 3618.5 3651.5 1366.5 1368.8 1398.9 1419.3 1467.5 10879.3 11396.9 11541.7 11664.6 11895.1 4680.8 4752.9 4765.2 4919.7 4948.9 10234.1 10234.6 10248.0 10287.2 10306.8 5415.1 5458.5 5479.9 5482.3 5488.5 4910.6 5058.4 5060.1 5130.8 5199.8 3897.0 3956.3 3970.0 4009.1 4066.0 1165.1 1171.3 1182.0 1182.4 1193.4 1006.3 1019.7 1022.5 1033.7 1035.5 5901.4 5912.8 5984.6 6032.9 6190.9 1047.1 1081.4 1086.1 1101.2 1138.7 3967.3 4146.7 4166.6 4169.8 4246.9 9988.8 10279.5 10304.3 10358.4 10394.6 10096.8 10205.3 10244.0 10316.1 10332.6 8047.7 8120.0 8248.8 8250.3 8279.0 5540.3 5603.0 5622.0 5672.6 5739.1 9320.9 9567.9 9602.4 9631.1 9681.5 9094.1 9467.6 9517.2 9588.9 9671.2 7441.9 7613.2 7700.2 7781.3 7949.1 8377.0 8401.1 8424.9 8479.5 8486.7 7240.0 7266.3 7290.3 7319.0 7570.6 6902.9 6908.7 6945.1 6960.7 6974.8 6764.5 6823.7 6856.8 6864.2 6875.2 5216.3 5243.0 5246.5 5266.6 5413.2 5130.7 5143.3 5183.7 5208.0 5330.5 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | [#4] prototype.html Cycles:180 Average:4895.70 Median:5509.31 stddev:1363.40 (24.7%) stddev-sans-first:1324.88 01:15:06 INFO - PROCESS | 13196 | Values: 403.2 412.1 415.1 425.6 429.6 5338.5 5485.6 5488.7 5542.8 5590.7 5284.4 5417.9 5437.7 5479.4 5481.8 4383.4 4393.3 4397.8 4412.5 4414.6 4352.7 4375.5 4410.0 4421.3 4459.4 4332.9 4340.3 4341.9 4357.4 4363.7 4332.2 4333.3 4346.4 4371.3 4393.1 3902.7 4030.7 4043.7 4047.1 4063.3 5326.7 5351.5 5425.3 5444.6 5447.5 5123.4 5126.4 5139.5 5144.4 5166.9 5576.2 5773.6 5788.5 5792.0 5854.3 4489.7 4494.4 4497.8 4498.2 4512.5 5953.3 5979.5 5999.2 6015.8 6016.5 4363.0 4525.6 4557.3 4642.4 4646.9 4652.4 4654.8 4657.5 4663.6 4663.7 5129.8 5154.6 5163.4 5163.4 5169.5 5690.6 5765.5 5780.9 5826.3 5837.5 1499.6 1568.5 1570.5 1572.1 1582.6 1113.6 1130.4 1133.9 1147.2 1150.2 5537.7 5575.4 5604.6 5614.0 5620.2 5616.2 5751.4 5751.9 5777.2 5789.4 5466.6 5524.4 5531.7 5533.2 5589.4 3028.4 3036.6 3038.9 3048.7 3080.0 5770.6 5832.3 5935.8 5983.2 5984.0 5776.5 5787.3 5805.3 5820.9 5838.4 5876.0 5910.4 5930.3 5947.9 5987.9 5424.7 5669.7 5677.3 5692.0 5704.3 5636.8 5649.7 5659.1 5661.6 5708.3 5845.0 5908.8 5910.0 5974.5 5983.1 4245.6 4331.2 4335.2 4337.4 4349.5 5815.9 5834.4 5947.9 5958.7 5994.0 5716.6 5765.2 5774.3 5786.5 5794.2 5749.0 5778.8 5801.2 5801.6 5830.8 5639.9 5763.1 5765.5 5794.6 5803.3 5787.8 5801.3 5814.2 5847.2 5862.4 5494.2 5601.4 5648.5 5723.6 5754.2 01:15:06 INFO - PROCESS | 13196 | 01:15:06 INFO - PROCESS | 13196 | [#5] yui.html Cycles:180 Average:18990.14 Median:4441.19 stddev:23956.28 (539.4%) stddev-sans-first:23984.63 01:15:06 INFO - PROCESS | 13196 | Values: 819.0 840.7 851.6 915.3 938.0 15699.8 15966.5 16277.3 16729.4 16747.2 16293.3 16516.3 16566.8 16675.9 16901.6 817.8 818.6 830.2 831.8 832.1 797.6 844.0 844.9 848.4 853.6 875.3 878.1 878.2 881.6 882.5 865.5 868.6 874.6 874.7 875.7 641.9 644.3 644.5 645.0 646.5 14778.9 14981.9 17198.0 17725.2 17816.5 14542.0 15730.7 16052.4 16088.5 16409.3 12868.8 12927.4 13046.3 13073.4 13177.2 4804.1 4813.8 4872.9 4896.3 4912.7 86545.0 87424.1 88018.6 88427.0 88917.6 12067.5 12500.0 12547.1 12596.6 12599.0 21259.2 22705.1 22866.2 22984.2 23269.1 8832.6 8908.6 8916.3 9020.3 9077.9 4439.9 4442.5 4472.0 4511.9 4584.9 3711.5 3727.1 3760.2 3786.1 3787.0 627.6 631.7 641.0 647.2 653.9 782.2 782.5 790.7 807.5 816.6 10417.0 10751.5 10836.0 10844.3 11011.0 782.8 788.9 820.5 828.1 840.9 4963.9 5117.7 5125.6 5148.5 5154.0 63260.4 73883.0 83291.0 87403.6 87906.0 72579.6 73490.6 74058.6 74725.3 75450.0 67983.3 68159.3 68181.3 68935.0 70235.3 10793.4 11528.5 11625.7 12119.9 12189.1 42349.4 43035.1 43100.4 43275.8 43383.1 58794.0 58808.0 59790.1 60908.7 61959.4 13534.9 13832.2 13848.4 13927.4 13950.8 16236.7 16271.7 16284.5 16761.8 17335.9 15289.5 15424.4 15765.0 15798.7 16225.3 14155.5 14205.3 14383.1 14508.6 14744.7 14895.0 15073.2 15251.5 15320.5 15529.1 12191.9 12213.5 12440.5 12624.2 12967.4 12371.4 12523.6 12662.4 12695.7 12711.1 01:15:06 INFO - PROCESS | 13196 | -------- Summary: end -------- 01:15:06 INFO - PROCESS | 13196 | 01:15:07 INFO - TEST-INFO | 13196: exit 0 01:15:07 INFO - TEST-OK | dromaeo_css | took 1111345ms 01:15:07 INFO - TEST-START | kraken 01:15:07 INFO - operating with platform_type : linux_ 01:15:07 INFO - Initialising browser for kraken test... 01:15:07 INFO - TEST-INFO | started process 13573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEGFpG/profile http://localhost:51333/getInfo.html) 01:15:11 INFO - PROCESS | 13573 | __metrics Screen width/height:1600/1200 01:15:11 INFO - PROCESS | 13573 | colorDepth:24 01:15:11 INFO - PROCESS | 13573 | Browser inner width/height: 1024/697 01:15:11 INFO - PROCESS | 13573 | __metrics 01:15:12 INFO - PROCESS | 13573 | 1486458912288 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/tmpxEGFpG/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpxEGFpG/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpxEGFpG/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpxEGFpG/profile/extensions/talos-powers@TalosPowersService.js:55:9 01:15:12 ERROR - PROCESS | 13573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:15:13 INFO - TEST-INFO | 13573: exit 0 01:15:13 INFO - Browser initialized. 01:15:13 INFO - Running cycle 1/1 for kraken test... 01:15:13 INFO - TEST-INFO | started process 13698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEGFpG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:25 INFO - PROCESS | 13698 | RSS: Main: 144789504 01:15:25 INFO - PROCESS | 13698 | 01:15:27 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51333/tests/kraken/driver.html?testName=audio-beat-detection) 01:15:28 INFO - PROCESS | 13698 | RSS: Main: 151400448 01:15:28 INFO - PROCESS | 13698 | 01:15:31 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51333/tests/kraken/driver.html?testName=audio-dft) 01:15:31 INFO - PROCESS | 13698 | RSS: Main: 150335488 01:15:31 INFO - PROCESS | 13698 | 01:15:34 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51333/tests/kraken/driver.html?testName=audio-fft) 01:15:35 INFO - PROCESS | 13698 | RSS: Main: 150249472 01:15:35 INFO - PROCESS | 13698 | 01:15:37 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51333/tests/kraken/driver.html?testName=audio-oscillator) 01:15:37 INFO - PROCESS | 13698 | RSS: Main: 150122496 01:15:37 INFO - PROCESS | 13698 | 01:15:39 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:15:40 INFO - PROCESS | 13698 | RSS: Main: 150257664 01:15:40 INFO - PROCESS | 13698 | 01:15:43 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51333/tests/kraken/driver.html?testName=imaging-darkroom) 01:15:44 INFO - PROCESS | 13698 | RSS: Main: 153444352 01:15:44 INFO - PROCESS | 13698 | 01:15:47 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51333/tests/kraken/driver.html?testName=imaging-desaturate) 01:15:48 INFO - PROCESS | 13698 | RSS: Main: 154091520 01:15:48 INFO - PROCESS | 13698 | 01:15:51 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51333/tests/kraken/driver.html?testName=json-parse-financial) 01:15:51 INFO - PROCESS | 13698 | RSS: Main: 152760320 01:15:51 INFO - PROCESS | 13698 | 01:15:53 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:15:53 INFO - PROCESS | 13698 | RSS: Main: 152076288 01:15:53 INFO - PROCESS | 13698 | 01:15:55 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:15:56 INFO - PROCESS | 13698 | RSS: Main: 152633344 01:15:56 INFO - PROCESS | 13698 | 01:15:58 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:15:58 INFO - PROCESS | 13698 | RSS: Main: 152588288 01:15:58 INFO - PROCESS | 13698 | 01:16:01 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:16:02 INFO - PROCESS | 13698 | RSS: Main: 152891392 01:16:02 INFO - PROCESS | 13698 | 01:16:04 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:16:05 INFO - PROCESS | 13698 | RSS: Main: 153690112 01:16:05 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | Cycle 1(1): loaded http://localhost:51333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51333/tests/kraken/driver.html?testName=ai-astar) 01:16:07 INFO - PROCESS | 13698 | RSS: Main: 155058176 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | __start_tp_report 01:16:07 INFO - PROCESS | 13698 | _x_x_mozilla_page_load 01:16:07 INFO - PROCESS | 13698 | _x_x_mozilla_page_load_details 01:16:07 INFO - PROCESS | 13698 | |i|pagename|runs| 01:16:07 INFO - PROCESS | 13698 | |0;ai-astar;106;114;115;113;112;113;113;114;111;115 01:16:07 INFO - PROCESS | 13698 | |1;audio-beat-detection;143;119;118;158;119;119;120;117;135;118 01:16:07 INFO - PROCESS | 13698 | |2;audio-dft;160;163;166;162;163;161;160;164;161;162 01:16:07 INFO - PROCESS | 13698 | |3;audio-fft;75;78;76;111;82;76;77;76;94;76 01:16:07 INFO - PROCESS | 13698 | |4;audio-oscillator;83;83;101;85;82;82;93;81;82;101 01:16:07 INFO - PROCESS | 13698 | |5;imaging-gaussian-blur;117;118;117;118;121;118;118;118;116;118 01:16:07 INFO - PROCESS | 13698 | |6;imaging-darkroom;149;147;152;148;148;150;148;148;148;147 01:16:07 INFO - PROCESS | 13698 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;97;96 01:16:07 INFO - PROCESS | 13698 | |8;json-parse-financial;56;56;57;56;56;59;55;55;55;55 01:16:07 INFO - PROCESS | 13698 | |9;json-stringify-tinderbox;65;65;65;66;65;66;65;66;65;65 01:16:07 INFO - PROCESS | 13698 | |10;stanford-crypto-aes;78;80;78;77;76;77;78;76;75;77 01:16:07 INFO - PROCESS | 13698 | |11;stanford-crypto-ccm;122;123;122;128;123;121;121;130;156;121 01:16:07 INFO - PROCESS | 13698 | |12;stanford-crypto-pbkdf2;161;160;161;169;160;160;164;160;165;161 01:16:07 INFO - PROCESS | 13698 | |13;stanford-crypto-sha256-iterative;62;63;64;68;63;61;60;65;61;66 01:16:07 INFO - PROCESS | 13698 | __end_tp_report 01:16:07 INFO - PROCESS | 13698 | __start_cc_report 01:16:07 INFO - PROCESS | 13698 | _x_x_mozilla_cycle_collect,704 01:16:07 INFO - PROCESS | 13698 | __end_cc_report 01:16:07 INFO - PROCESS | 13698 | __startTimestamp1486458967443__endTimestamp 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | ------- Summary: start ------- 01:16:07 INFO - PROCESS | 13698 | Number of tests: 14 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:2.63 (2.3%) stddev-sans-first:1.32 01:16:07 INFO - PROCESS | 13698 | Values: 106.0 114.0 115.0 113.0 112.0 113.0 113.0 114.0 111.0 115.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:119.50 stddev:14.07 (11.8%) stddev-sans-first:13.62 01:16:07 INFO - PROCESS | 13698 | Values: 143.0 119.0 118.0 158.0 119.0 119.0 120.0 117.0 135.0 118.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.87 (1.2%) stddev-sans-first:1.81 01:16:07 INFO - PROCESS | 13698 | Values: 160.0 163.0 166.0 162.0 163.0 161.0 160.0 164.0 161.0 162.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.50 stddev:11.64 (15.2%) stddev-sans-first:12.06 01:16:07 INFO - PROCESS | 13698 | Values: 75.0 78.0 76.0 111.0 82.0 76.0 77.0 76.0 94.0 76.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:82.50 stddev:7.99 (9.7%) stddev-sans-first:8.32 01:16:07 INFO - PROCESS | 13698 | Values: 83.0 83.0 101.0 85.0 82.0 82.0 93.0 81.0 82.0 101.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 01:16:07 INFO - PROCESS | 13698 | Values: 117.0 118.0 117.0 118.0 121.0 118.0 118.0 118.0 116.0 118.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:1.51 (1.0%) stddev-sans-first:1.59 01:16:07 INFO - PROCESS | 13698 | Values: 149.0 147.0 152.0 148.0 148.0 150.0 148.0 148.0 148.0 147.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:16:07 INFO - PROCESS | 13698 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.25 (2.2%) stddev-sans-first:1.32 01:16:07 INFO - PROCESS | 13698 | Values: 56.0 56.0 57.0 56.0 56.0 59.0 55.0 55.0 55.0 55.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 01:16:07 INFO - PROCESS | 13698 | Values: 65.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.50 stddev:1.40 (1.8%) stddev-sans-first:1.45 01:16:07 INFO - PROCESS | 13698 | Values: 78.0 80.0 78.0 77.0 76.0 77.0 78.0 76.0 75.0 77.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:123.00 stddev:10.75 (8.7%) stddev-sans-first:11.27 01:16:07 INFO - PROCESS | 13698 | Values: 122.0 123.0 122.0 128.0 123.0 121.0 121.0 130.0 156.0 121.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:161.00 stddev:3.00 (1.9%) stddev-sans-first:3.15 01:16:07 INFO - PROCESS | 13698 | Values: 161.0 160.0 161.0 169.0 160.0 160.0 164.0 160.0 165.0 161.0 01:16:07 INFO - PROCESS | 13698 | 01:16:07 INFO - PROCESS | 13698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:2.50 (3.9%) stddev-sans-first:2.60 01:16:07 INFO - PROCESS | 13698 | Values: 62.0 63.0 64.0 68.0 63.0 61.0 60.0 65.0 61.0 66.0 01:16:07 INFO - PROCESS | 13698 | -------- Summary: end -------- 01:16:07 INFO - PROCESS | 13698 | 01:16:08 INFO - TEST-INFO | 13698: exit 0 01:16:08 INFO - TEST-OK | kraken | took 60900ms 01:16:08 INFO - SUITE-END | took 1172s 01:16:08 INFO - Completed test suite (00:19:32) 01:16:08 INFO - javascript benchmark 01:16:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7627.508609609996, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3230.628477725062, 3241.1897025743565, 3263.592050993626, 3297.950530742041, 3307.685769851864, 5375.784968601256, 5428.348598168215, 5438.673679579223, 5455.454454554542, 5473.397926228112, 5478.890422191554, 5511.255980442639, 5529.612927095095, 5538.584606154544, 5554.888902221953, 4903.8774030649165, 4931.038447502739, 4986.700797952117, 4998.300237966688, 5008.4240312364, 4960.032793605248, 4963.106640804672, 4993.076280888029, 5003.824866129687, 5024.095662780698, 4786.401699787527, 4797.9760101199445, 4955.0, 4960.206366981283, 4978.327925730035, 4881.975590122044, 4884.267359896026, 4920.040592084545, 4953.851384458472, 5017.247412888059, 4939.0121975605025, 4948.084604348207, 4949.455559888409, 4958.752062396866, 4984.626153038536, 5454.4545545445535, 5468.699221542814, 5485.780568777244, 5549.1676248562635, 5555.583331250173, 5690.487856092972, 5722.456366645204, 5739.311282646109, 5762.654240745569, 5787.594868359217, 5886.3230728465915, 5893.263342082239, 5900.97049514754, 5901.940980590225, 5938.2280303560265, 5490.917636235459, 5493.121100623881, 5493.478119578634, 5498.0, 5500.944990550123, 5794.652320860678, 5819.679917604488, 5880.2943646761805, 5916.0, 5935.7625694972585, 5716.399778023331, 5745.052066408995, 5761.251037365116, 5802.100674395476, 5804.100364443518, 5776.56675749312, 5805.129230615442, 5827.970860145672, 5829.912551311733, 5868.178455016301, 5715.257016587817, 5764.337101233328, 5767.336756272998, 5826.0678291474005, 5845.181674565564, 5795.449432303924, 5895.4399332063385, 5901.881962360729, 5910.704464776744, 5935.643861368331, 4494.37078808967, 4504.009117994036, 4506.211413002777, 4511.684182107287, 4537.069900670354, 3954.6638535724787, 3958.604139586076, 3961.088949541622, 4013.8996525086523, 4059.3099173140045, 5704.600677952503, 5763.423657634203, 5769.48074673273, 5797.246357973437, 5809.244798176294, 5828.271466066742, 5897.32180799205, 5933.406659334119, 5934.109883517421, 5948.9702551487835, 5595.132754423071, 5609.607327487037, 5634.6337488063145, 5752.971235143881, 5766.077427611562, 4964.90070198594, 5006.199008158677, 5011.07295150391, 5026.673266237683, 5030.220315851049, 6013.639181649028, 6055.152278680988, 6079.05774604937, 6084.056971169476, 6091.939080609137, 5688.516476099578, 5713.342965558848, 5867.911981320369, 5870.295564532284, 5870.354261031198, 6037.0642550404755, 6058.818235452944, 6065.090236464565, 6102.816915492543, 6138.232720909887, 5750.194972703741, 5774.249347584787, 5801.245838041028, 5804.158397032322, 5811.941880581309, 5664.886702266014, 5825.533957283492, 5828.271466066742, 5832.183494310715, 5844.94155058444, 5524.14375771756, 5649.915251271152, 5674.262345895172, 5716.628419152742, 5825.854353641193, 5700.914486282626, 5712.428757124254, 5713.371529131709, 5723.170140329712, 5748.993926063006, 5675.091985282335, 5744.712764361681, 5757.3954734753925, 5764.654120752768, 5767.826965191051, 5477.1510415885605, 5528.75120619565, 5640.661560306395, 5667.036603777286, 5699.572532060195, 5591.329040515164, 5617.550595952396, 5633.774649013993, 5640.492355688008, 5668.886622267449], "value": 5399.525429561361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8010766393259, 612.6324205476714, 619.869827336259, 623.4638211138421, 646.7122130651856, 46964.295535566955, 48283.275750863766, 48410.0, 51626.0, 52011.47988520114, 50111.49888501123, 50357.0, 50803.491965080335, 50810.0, 51106.23340649893, 9183.173514383687, 9392.7651808705, 9409.341346105775, 9414.152726254635, 10745.946270268638, 10655.84016239757, 10941.070009049241, 10980.450977451135, 11002.394868282241, 11006.394648294341, 11049.668509944675, 11057.723556911062, 11092.500837462294, 11101.666949991513, 11130.666080017612, 10998.945005275002, 11025.173112016631, 11033.227674062819, 11088.33469991795, 11118.277311974696, 11007.174461915389, 11016.228863979524, 11047.779044419147, 11065.557377704883, 11067.0, 41709.58290417087, 42279.365809512885, 42341.36487952683, 42385.36421953673, 42476.78761606203, 4464.107178564268, 4489.932651010237, 4505.481869584974, 4510.774461276923, 4633.837815676435, 31552.368952620818, 32262.0, 32564.6743532564, 32711.6728832711, 32845.17887052819, 4650.558196971282, 4651.023285110131, 4664.043871006435, 4701.882452938669, 4704.388429504143, 378900.0, 379452.0, 381720.0, 382504.0, 385413.0, 61426.0, 62208.0, 62247.377526225064, 62306.37693623006, 62314.376856230854, 65047.67476162589, 65158.67420662866, 65299.34700652933, 65424.345756542774, 65895.34104658892, 19210.327638532584, 19375.806241937684, 19531.609367812565, 19547.8045219546, 19570.412887613395, 14661.193634350213, 14942.178180200193, 15288.235588220545, 15471.071735695894, 15830.129342886252, 20360.49098772513, 20652.896735516526, 20678.379648610568, 20687.8965605174, 20746.79253207479, 7336.413086953031, 7352.705891764376, 7365.852682946311, 7518.736844210426, 7523.210062943422, 994.4381424495137, 1010.7068950004564, 1038.413296487482, 1038.963636272742, 1054.9683509494728, 34342.82828585891, 34417.13957151091, 34688.0, 34887.0, 35236.00493957991, 1157.3171828621155, 1168.8597368315857, 1172.2204733852063, 1174.2426135142784, 1181.3207405741732, 15938.840611593967, 15967.760483592756, 16024.679506409806, 16143.838561614233, 16291.42979995718, 510711.0, 512053.0, 513956.0, 515901.0, 523901.0, 60655.39344606586, 60928.390716093156, 61252.0, 61322.38677613256, 61343.07985380223, 1554.9067055976677, 1565.4833904811385, 1573.0404453283488, 1593.9043657380826, 1601.5755824706462, 29544.0, 30396.088117356514, 31192.376152477278, 31333.686663133078, 32528.186795330304, 60462.09306860489, 60988.39011609827, 61291.08063379142, 61339.0, 61388.38611613827, 483415.0, 487413.0, 488941.0, 489092.0, 491400.0, 43077.35383969306, 43626.0, 44905.32642010307, 44963.775181125195, 45074.0, 47782.76108619435, 47836.760816195696, 48176.27735583899, 48623.75688121537, 49627.0, 40689.0, 42722.786386069114, 42882.35676464793, 42910.356344655476, 43220.351694725236, 39692.60307397004, 41403.378949316386, 41888.0, 42218.57781422146, 42270.50980158371, 40535.18929621332, 40940.1811963765, 41339.7933010333, 42129.0, 42132.78933605312, 35336.46995295021, 35359.646403536666, 36018.09954751152, 36640.26719465649, 36903.0, 28096.43807123887, 28707.282317941383, 28819.855900720362, 28928.276793080342, 29039.0], "value": 22034.794596092936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.19890302392093, 439.0604107210569, 439.3300217168819, 443.200023956758, 446.38408959566357, 20723.378298651045, 21699.240526581572, 22065.227717029906, 22200.888995555, 22481.775182248173, 20491.0, 22198.445038874037, 22832.65751013736, 22879.656805147937, 22983.42541436465, 5944.464998150165, 5963.910541341883, 6162.291336496293, 6169.10547970544, 6169.907451388232, 5842.269716285465, 5957.910631340534, 5991.490723288504, 5998.610090344114, 6006.609570377911, 5805.36141024487, 5853.531717462614, 5941.910871336933, 5942.049272116462, 5947.851303717398, 5838.854028649296, 5895.911561326584, 5905.468507834273, 5923.466887980081, 5930.229070220887, 5220.582353411718, 5241.187615919539, 5243.737813109329, 5255.86860328491, 5321.095413779667, 24910.626340604904, 24961.0, 24998.625020624706, 25280.620790688154, 25291.494170116493, 3401.6258211596705, 3412.5904891412943, 3418.077119177833, 3434.1242983039415, 3466.878659246914, 14791.630209244748, 15010.324535395934, 15013.849861501354, 15557.611059723484, 15656.138912359816, 2009.718639390472, 2058.5059585699323, 2103.5897999890026, 2217.634090375086, 2251.0883092347626, 97389.513052435, 98293.50853245688, 99010.50494747552, 99571.0, 101217.0, 12337.814932776015, 12341.3829308536, 12416.503339866485, 12502.624501344715, 12528.749425011449, 18092.638147236983, 18094.095295235187, 18106.45680629583, 18183.818161818213, 18185.909070454563, 8914.910850891538, 8967.865482017774, 8990.235829954396, 9085.636574537077, 9153.77115572116, 8482.491050536988, 8611.354148438892, 8634.525101119372, 8805.603747831236, 8820.206181443573, 5185.7407129644125, 5297.417284098746, 5382.300300960928, 5435.10320797064, 5458.426865179099, 2089.529855782467, 2145.903434345458, 2167.8048975592274, 2196.341097670724, 2201.669749537582, 1119.160629527854, 1140.2417392434104, 1142.6343570057668, 1161.4715304536417, 1164.8136298192248, 20520.58958820845, 20574.485637858874, 20606.381808545768, 20635.17459301641, 20690.793092069187, 1170.0347213548857, 1183.1067544004393, 1197.8921897029309, 1204.1631066408936, 1208.2146604706836, 11372.203945723886, 11417.942910285561, 11509.597164099216, 11514.194006419637, 11525.0, 657866.0, 676618.0, 699445.0, 748795.0, 774281.0, 95634.0, 99696.0, 110859.0, 117929.0, 123852.0, 521.2025600830735, 543.5515699547889, 544.2978557660653, 545.6753231827057, 547.8630342414397, 11646.24299420535, 12024.879751202727, 12139.57511487129, 12167.57413490559, 12415.193012454161, 41000.17999639931, 41105.79447102745, 41700.0, 46449.53550464452, 47442.52557474381, 56993.43006570047, 68137.65931170313, 68746.0, 68895.96656050063, 69205.3079469219, 9211.355205135576, 9403.717888463358, 9544.236461082957, 9652.66215682476, 9821.558029888814, 8011.719589814328, 12680.668529804238, 14339.211343376215, 14967.77548336754, 15003.324850381978, 12031.0, 12281.263124212219, 12333.471638314304, 12453.315067671365, 12847.678808029501, 12304.938475307566, 12360.75278494407, 12510.937445313079, 12570.057245706792, 12641.557545485864, 12414.317212553397, 12555.560555380518, 12725.236485810881, 12747.936260318638, 12903.0, 9681.757956051155, 9811.411315321104, 9914.256430767577, 9933.255005874444, 10014.749631259278, 11957.222780519587, 12536.874631253935, 12612.684682882635, 12630.936845315715, 12644.936775316064], "value": 10036.228503396285, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.17222355481, 1506.2920427399122, 1511.5692027772084, 1515.969680606388, 1520.6654536002075, 8243.505389676617, 8500.61747221375, 8768.649254029839, 8784.1655042771, 8893.777655558615, 8530.658773649062, 8609.182127697859, 8692.0, 8700.173483519071, 8707.434016788904, 2447.608382658775, 2468.1731619907355, 2484.3043947694673, 2492.3395300245447, 2493.7381574934643, 2414.7343792182846, 2459.8401103928277, 2476.9752302477013, 2480.355107672009, 2482.156066937241, 2432.1609044879488, 2457.1154384421593, 2466.075221791828, 2475.2450502596703, 2480.454300053985, 2393.8324317297797, 2396.209250947183, 2398.484325869929, 2408.036785285882, 2430.149447693311, 2366.349253955159, 2386.4869053153484, 2401.2916189724074, 2418.03278688526, 2419.358869899478, 8791.81310523084, 8796.780080497974, 8819.0, 8819.250363719091, 8868.911310886873, 5315.893682126374, 5442.374126975409, 5446.2375267462585, 5450.400455949843, 5457.699826509541, 3502.176988407722, 3554.4668299755244, 3573.94639080414, 3618.475321078455, 3651.5070465487083, 1366.5422083602004, 1368.8288963879515, 1398.923059231752, 1419.332913530639, 1467.4790449390525, 10879.347239165596, 11396.943015284953, 11541.711457213636, 11664.591739289084, 11895.107866910017, 4680.81276748933, 4752.881177970509, 4765.213739732974, 4919.704817710949, 4948.901021979612, 10234.130098941674, 10234.6417875374, 10247.975202479842, 10287.22845786569, 10306.845397319046, 5415.0523658359625, 5458.4814442627885, 5479.945200547943, 5482.342118945752, 5488.4785945335125, 4910.631702622318, 5058.3929928408825, 5060.139776238048, 5130.846074617767, 5199.766010529535, 3897.025743564109, 3956.2680904032845, 3969.980150099231, 4009.1380353223612, 4066.0, 1165.1319766773809, 1171.308927732642, 1181.9586314478952, 1182.3910685996718, 1193.3794426897964, 1006.3106771861152, 1019.6838979916249, 1022.4836457589018, 1033.705393962717, 1035.4615599888016, 5901.40985901415, 5912.793052243151, 5984.640921544721, 6032.939670603326, 6190.876182476325, 1047.146575540947, 1081.3998230981724, 1086.1093902999464, 1101.2126329674322, 1138.6811692725885, 3967.2858885400906, 4146.66826653867, 4166.58334166587, 4169.812358443877, 4246.8725938221905, 9988.750281243027, 10279.486025698685, 10304.330218535772, 10358.378497290187, 10394.584216631401, 10096.798064038678, 10205.336653117523, 10244.0, 10316.071553560216, 10332.638357657446, 8047.718329858544, 8119.959400202961, 8248.793780155424, 8250.339972802161, 8279.0, 5540.335159780852, 5603.0, 5622.0, 5672.60291779588, 5739.110437882135, 9320.906790932004, 9567.856482152634, 9602.375845570015, 9631.133198012212, 9681.467519286225, 9094.136057074567, 9467.621295148392, 9517.23862091045, 9588.90411095908, 9671.226301895973, 7441.888371674538, 7613.200613935457, 7700.229977002479, 7781.26078022587, 7949.085855126503, 8377.0, 8401.117882622237, 8424.873626895478, 8479.533625650649, 8486.702965396182, 7239.963800181176, 7266.346028857428, 7290.270972902667, 7319.048523691886, 7570.5836179010685, 6902.8619427612175, 6908.654567271717, 6945.0971373721095, 6960.721571137098, 6974.79075627732, 6764.526483146133, 6823.658817059227, 6856.794296171123, 6864.24493305726, 6875.1749790025515, 5216.347956505437, 5243.0, 5246.475352464723, 5266.605004624592, 5413.215083812746, 5130.692158470503, 5143.254228136974, 5183.740812959412, 5208.0, 5330.54690351309], "value": 4676.411163339907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.2237941961723, 412.11395499675695, 415.0868090201556, 425.6211971345502, 429.5682838747061, 5338.546223571001, 5485.61600687952, 5488.710153114015, 5542.806001789938, 5590.66456012639, 5284.44513326101, 5417.864553386167, 5437.667771396003, 5479.424660410659, 5481.780728770845, 4383.356241409471, 4393.340998850182, 4397.824087036514, 4412.536683648219, 4414.602685758281, 4352.695311328208, 4375.496817865938, 4410.0, 4421.292593185091, 4459.375687403766, 4332.935005974913, 4340.348947657845, 4341.891452713691, 4357.368181613664, 4363.650907927374, 4332.155229730204, 4333.263345231302, 4346.3915051892445, 4371.256886329332, 4393.143337049277, 3902.7072969527117, 4030.6775457963295, 4043.6562892153906, 4047.0978640039134, 4063.349864021742, 5326.7070311132875, 5351.518363347317, 5425.256572964642, 5444.6188766786345, 5447.509724124809, 5123.436421993578, 5126.410462796789, 5139.537441630271, 5144.4083930348115, 5166.870828229286, 5576.247206627094, 5773.595848290622, 5788.450097240798, 5791.971040144815, 5854.268216472941, 4489.708168969007, 4494.415725955638, 4497.820087196508, 4498.190325741365, 4512.503624601291, 5953.3451320354725, 5979.521638268971, 5999.220101386792, 6015.789447369365, 6016.465801220748, 4362.9781851091175, 4525.551823416541, 4557.339185818038, 4642.442906851199, 4646.86059418218, 4652.441706995182, 4654.790534425959, 4657.534246575383, 4663.603593694574, 4663.743494107789, 5129.846104616868, 5154.639175257696, 5163.3545806774155, 5163.432022477525, 5169.457206993212, 5690.630109042899, 5765.538756899438, 5780.942190578125, 5826.261657021193, 5837.474627283565, 1499.5651261134149, 1568.4588816858166, 1570.4503423801577, 1572.1448690545267, 1582.596437908326, 1113.5768408005067, 1130.3613458396144, 1133.9489722962487, 1147.2198904744853, 1150.183369807446, 5537.6954267515675, 5575.386707462176, 5604.551635869121, 5613.971930140323, 5620.185073164368, 5616.213730077792, 5751.396103409165, 5751.8562035949435, 5777.215923570068, 5789.3921138279875, 5466.617336786467, 5524.447555244444, 5531.723413829292, 5533.1976863354585, 5589.357223919302, 3028.394321135782, 3036.5596988436555, 3038.878444862225, 3048.7103725146076, 3079.969200308013, 5770.596058275964, 5832.300123985149, 5935.762569497172, 5983.222181116514, 5984.012637914782, 5776.537876969833, 5787.305523337226, 5805.274340707411, 5820.933568583092, 5838.357780644125, 5876.0, 5910.438508341701, 5930.28836539618, 5947.86990471809, 5987.880242395127, 5424.728763561727, 5669.744861481326, 5677.3471050829685, 5691.971540142438, 5704.3154821421695, 5636.774529018793, 5649.71751412436, 5659.075914189196, 5661.631993920382, 5708.343540492897, 5845.0, 5908.763649453974, 5910.0, 5974.492168165581, 5983.14522498027, 4245.596668316505, 4331.198728235287, 4335.1979883721615, 4337.3927650129635, 4349.521552629271, 5815.912761308499, 5834.38738932406, 5947.910781338197, 5958.702064896825, 5993.9700301498215, 5716.628419152742, 5765.192872997867, 5774.335951365647, 5786.508146807569, 5794.246747922743, 5748.971255143698, 5778.8266352009505, 5801.245838041196, 5801.622894511843, 5830.795922142875, 5639.88720225585, 5763.135529670583, 5765.452282033368, 5794.565407594363, 5803.274590676166, 5787.768489260382, 5801.274840644919, 5814.186013957965, 5847.181394604674, 5862.355140934408, 5494.175873618829, 5601.383847776659, 5648.540777023116, 5723.599348045597, 5754.165645981393], "value": 4486.874419530456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.9845584184166, 840.6595328891793, 851.5529347092779, 915.2860768600492, 937.9812403751926, 15699.843001569981, 15966.521004369888, 16277.348906043773, 16729.414470493535, 16747.16264186789, 16293.266802993865, 16516.25676844542, 16566.83433165668, 16675.916620416912, 16901.57746056349, 817.7505860712465, 818.6193420059672, 830.1615368477851, 831.787894087007, 832.1304237072244, 797.5892415406071, 844.0167205205928, 844.9155084491563, 848.3764433141666, 853.5774791478227, 875.2560323724847, 878.086789738671, 878.2359347367799, 881.6164968238804, 882.4881568690176, 865.5455885660048, 868.5700578213794, 874.5627186406797, 874.654511467973, 875.711015364928, 641.8972964325685, 644.3041515163659, 644.4779728419995, 644.9903251451232, 646.5215740352153, 14778.852211477855, 14981.850181498263, 17197.968121912727, 17725.202365893438, 17816.46550603484, 14542.0, 15730.68538629221, 16052.357905683759, 16088.517344479684, 16409.343626254937, 12868.806967895489, 12927.418266178045, 13046.282454465001, 13073.411696473682, 13177.209367437985, 4804.0872234275375, 4813.831515896927, 4872.902541949176, 4896.290037944478, 4912.7297998610065, 86545.0, 87424.12575874223, 88018.55990720005, 88427.0, 88917.55541222253, 12067.456964436622, 12499.999999999978, 12547.121701480992, 12596.55912043074, 12599.0, 21259.192968597843, 22705.091796328292, 22866.199683011346, 22984.195553155558, 23269.138468922447, 8832.5583720815, 8908.599113039929, 8916.331275154389, 9020.323475739215, 9077.863832042525, 4439.872379759666, 4442.511323754385, 4471.977640111779, 4511.932321015187, 4584.862454126382, 3711.5175027246823, 3727.086863718352, 3760.1539653578275, 3786.1291902862495, 3786.962130378716, 627.6296984778911, 631.6620607974711, 641.0416427441005, 647.2233320015999, 653.8855700252532, 782.24122601078, 782.4913806026128, 790.715342476708, 807.5033854179637, 816.5590581086266, 10417.0, 10751.462426878781, 10836.0, 10844.349339039683, 11011.0, 782.7769085810517, 788.8501184774874, 820.5404973215019, 828.0518805967254, 840.920112589303, 4963.851084467472, 5117.744112794346, 5125.615578831528, 5148.536631703165, 5153.974230128825, 63260.36739632545, 73883.0, 83291.0, 87403.56298218468, 87906.0, 72579.63710181415, 73490.63254683692, 74058.62970685112, 74725.25274747182, 75450.0, 67983.32016679869, 68159.31840681529, 68181.31818681849, 68935.0, 70235.29764702288, 10793.40636265013, 11528.532270122103, 11625.6512304631, 12119.878801211875, 12189.146759726735, 42349.36475952801, 43035.139297214504, 43100.353494696974, 43275.78362108169, 43383.13233735244, 58794.0, 58808.0, 59790.10314845194, 60908.69545652244, 61959.38040619536, 13534.864651353755, 13832.239226842621, 13848.427063885802, 13927.373268202753, 13950.79073813914, 16236.67526649484, 16271.67456650884, 16284.51146465608, 16761.832381676028, 17335.873168244023, 15289.541313760605, 15424.383024678888, 15765.0, 15798.684026319639, 16225.269862855963, 14155.504557340444, 14205.28973551339, 14383.065100768417, 14508.564743057725, 14744.705105897607, 14895.004954710443, 15073.246337682853, 15251.466198682992, 15320.46378376796, 15529.145896975775, 12191.878081219074, 12213.511459541518, 12440.502379904703, 12624.17942833713, 12967.41646625923, 12371.443285052013, 12523.624291271277, 12662.430190641258, 12695.682607934876, 12711.110222284351], "value": 7858.8282922844155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 115.0, 113.0, 112.0, 113.0, 113.0, 114.0, 111.0, 115.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 118.0, 158.0, 119.0, 119.0, 120.0, 117.0, 135.0, 118.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 166.0, 162.0, 163.0, 161.0, 160.0, 164.0, 161.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 111.0, 82.0, 76.0, 77.0, 76.0, 94.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 101.0, 85.0, 82.0, 82.0, 93.0, 81.0, 82.0, 101.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 121.0, 118.0, 118.0, 118.0, 116.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 152.0, 148.0, 148.0, 150.0, 148.0, 148.0, 148.0, 147.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 56.0, 59.0, 55.0, 55.0, 55.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 77.0, 76.0, 77.0, 78.0, 76.0, 75.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 122.0, 128.0, 123.0, 121.0, 121.0, 130.0, 156.0, 121.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 169.0, 160.0, 160.0, 164.0, 160.0, 165.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 68.0, 63.0, 61.0, 60.0, 65.0, 61.0, 66.0], "value": 63.3, "unit": "score"}]}]} 01:16:08 INFO - Return code: 0 01:16:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:16:08 ERROR - # TBPL SUCCESS # 01:16:08 INFO - Running post-action listener: _resource_record_post_action 01:16:08 INFO - [mozharness: 2017-02-07 09:16:08.743461Z] Finished run-tests step (success) 01:16:08 INFO - Running post-run listener: _resource_record_post_run 01:16:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363266048; Read time: 12; Write time: 240244 01:16:08 INFO - TinderboxPrint: CPU usage
13.3% 01:16:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:16:08 INFO - TinderboxPrint: I/O write bytes / time
363,266,048 / 240,244 01:16:08 INFO - TinderboxPrint: CPU idle
8,227.5 (86.7%) 01:16:08 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 01:16:08 INFO - TinderboxPrint: Swap in / out
0 / 0 01:16:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110243840; Read time: 0; Write time: 101272 01:16:08 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 253022208; Read time: 0; Write time: 138972 01:16:09 INFO - Running post-run listener: _upload_blobber_files 01:16:09 INFO - Blob upload gear active. 01:16:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:16:09 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 01:16:09 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:16:09 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:16:09 INFO - (blobuploader) - INFO - Open directory for files ... 01:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:10 INFO - (blobuploader) - INFO - Done attempting. 01:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:16:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:13 INFO - (blobuploader) - INFO - Done attempting. 01:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:16:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:15 INFO - (blobuploader) - INFO - Done attempting. 01:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:16 INFO - (blobuploader) - INFO - Done attempting. 01:16:16 INFO - (blobuploader) - INFO - Iteration through files over. 01:16:16 INFO - Return code: 0 01:16:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:16:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:16:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/268a582b822bd437ccbb06decdf51999e590e046a8bb310ec5eb74891ffc7663f668460f511867e5f8af7c6cf420bce73a6602c4d15b262bb8fb8061b3f9f454", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aa62f0c998d519548c93877a17c8f7df8db71f9025a1612f7a42fa8ac1639e184e5be8b8e5988a73d5955b5a1df821dbe245e763c0fdc6f01a53fec4ab86835d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e3d2b253d2f300892a3e74d157d0018ec83f4f6126d33614938f94914da63d8eddbbd4ec8481c7821fb5422921ec1a8e8aa83f5ff37f532e856c62b68673fe47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6d4bbbf9fb58d6efaab329001adb31157eb65fc85dba4fc8541e589ded8e5c6a7396cbd76e459d34b8051edeb8a28add58a3d6b86c879346c1159dd7d5d1023c"} 01:16:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:16:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:16:16 INFO - Contents: 01:16:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/268a582b822bd437ccbb06decdf51999e590e046a8bb310ec5eb74891ffc7663f668460f511867e5f8af7c6cf420bce73a6602c4d15b262bb8fb8061b3f9f454", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aa62f0c998d519548c93877a17c8f7df8db71f9025a1612f7a42fa8ac1639e184e5be8b8e5988a73d5955b5a1df821dbe245e763c0fdc6f01a53fec4ab86835d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e3d2b253d2f300892a3e74d157d0018ec83f4f6126d33614938f94914da63d8eddbbd4ec8481c7821fb5422921ec1a8e8aa83f5ff37f532e856c62b68673fe47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6d4bbbf9fb58d6efaab329001adb31157eb65fc85dba4fc8541e589ded8e5c6a7396cbd76e459d34b8051edeb8a28add58a3d6b86c879346c1159dd7d5d1023c"} 01:16:16 INFO - Running post-run listener: copy_logs_to_upload_dir 01:16:16 INFO - Copying logs to upload dir... 01:16:16 INFO - mkdir: /builds/slave/test/build/upload/logs 01:16:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.784364 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-02-07 01:16:15.896224) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 01:16:15.900031) ========= 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=1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/268a582b822bd437ccbb06decdf51999e590e046a8bb310ec5eb74891ffc7663f668460f511867e5f8af7c6cf420bce73a6602c4d15b262bb8fb8061b3f9f454", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aa62f0c998d519548c93877a17c8f7df8db71f9025a1612f7a42fa8ac1639e184e5be8b8e5988a73d5955b5a1df821dbe245e763c0fdc6f01a53fec4ab86835d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e3d2b253d2f300892a3e74d157d0018ec83f4f6126d33614938f94914da63d8eddbbd4ec8481c7821fb5422921ec1a8e8aa83f5ff37f532e856c62b68673fe47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6d4bbbf9fb58d6efaab329001adb31157eb65fc85dba4fc8541e589ded8e5c6a7396cbd76e459d34b8051edeb8a28add58a3d6b86c879346c1159dd7d5d1023c"} build_url:https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/268a582b822bd437ccbb06decdf51999e590e046a8bb310ec5eb74891ffc7663f668460f511867e5f8af7c6cf420bce73a6602c4d15b262bb8fb8061b3f9f454", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aa62f0c998d519548c93877a17c8f7df8db71f9025a1612f7a42fa8ac1639e184e5be8b8e5988a73d5955b5a1df821dbe245e763c0fdc6f01a53fec4ab86835d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e3d2b253d2f300892a3e74d157d0018ec83f4f6126d33614938f94914da63d8eddbbd4ec8481c7821fb5422921ec1a8e8aa83f5ff37f532e856c62b68673fe47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6d4bbbf9fb58d6efaab329001adb31157eb65fc85dba4fc8541e589ded8e5c6a7396cbd76e459d34b8051edeb8a28add58a3d6b86c879346c1159dd7d5d1023c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 01:16:15.924636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:16:15.924952) ========= 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=1f5564757af27664ca02d71f000001b0-1486457735.653335-154314092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:16:16.009828) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 01:16:16.010136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 01:16:16.010423) ========= ========= Total master_lag: 0.24 =========