builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1486457787.51 results: success (0) revision: 4116e3e124601c356950880ad01f015626b21345 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.506718) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.507183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.507469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.521080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.521417) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-07 00:56:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2017-02-07 00:56:27 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106095 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.638949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.639265) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013750 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:27.689548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-07 00:56:27.689893) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-07 00:56:27,779 truncating revision to first 12 chars 2017-02-07 00:56:27,779 Setting DEBUG logging. 2017-02-07 00:56:27,779 attempt 1/10 2017-02-07 00:56:27,779 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:56:29,626 unpacking tar archive at: mozilla-aurora-4116e3e12460/testing/mozharness/ program finished with exit code 0 elapsedTime=2.146543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-07 00:56:29.849323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:29.849660) ========= script_repo_revision: 4116e3e124601c356950880ad01f015626b21345 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:29.850035) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:29.850322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 00:56:29.860393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-07 00:56:29.861106) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:56:30 INFO - MultiFileLogger online at 20170207 00:56:30 in /builds/slave/test 00:56:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:56:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:56:30 INFO - {'append_to_log': False, 00:56:30 INFO - 'base_work_dir': '/builds/slave/test', 00:56:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 00:56:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:56:30 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 00:56:30 INFO - 'buildbot_json_path': 'buildprops.json', 00:56:30 INFO - 'config_files': ('talos/linux_config.py',), 00:56:30 INFO - 'default_actions': ('clobber', 00:56:30 INFO - 'read-buildbot-config', 00:56:30 INFO - 'download-and-extract', 00:56:30 INFO - 'populate-webroot', 00:56:30 INFO - 'create-virtualenv', 00:56:30 INFO - 'install', 00:56:30 INFO - 'run-tests'), 00:56:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:56:30 INFO - 'download_minidump_stackwalk': True, 00:56:30 INFO - 'download_symbols': 'ondemand', 00:56:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:56:30 INFO - 'tooltool.py': '/tools/tooltool.py', 00:56:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:56:30 INFO - '/tools/misc-python/virtualenv.py')}, 00:56:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:56:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:56:30 INFO - 'installer_path': 'installer.exe', 00:56:30 INFO - 'log_level': 'info', 00:56:30 INFO - 'log_name': 'talos', 00:56:30 INFO - 'log_to_console': True, 00:56:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:56:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:56:30 INFO - 'opt_config_files': (), 00:56:30 INFO - 'pip_index': False, 00:56:30 INFO - 'sps_profile': False, 00:56:30 INFO - 'sps_profile_interval': 0, 00:56:30 INFO - 'suite': 'dromaeojs', 00:56:30 INFO - 'system_bits': '32', 00:56:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:56:30 INFO - 'title': 'talos-linux64-ix-029', 00:56:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:56:30 INFO - 'use_talos_json': True, 00:56:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:56:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:56:30 INFO - 'work_dir': 'build'} 00:56:30 INFO - [mozharness: 2017-02-07 08:56:30.052104Z] Running clobber step. 00:56:30 INFO - Running pre-action listener: _resource_record_pre_action 00:56:30 INFO - Running main action method: clobber 00:56:30 INFO - rmtree: /builds/slave/test/build 00:56:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:56:30 INFO - Running post-action listener: _resource_record_post_action 00:56:30 INFO - [mozharness: 2017-02-07 08:56:30.518592Z] Finished clobber step (success) 00:56:30 INFO - [mozharness: 2017-02-07 08:56:30.518693Z] Running read-buildbot-config step. 00:56:30 INFO - Running pre-action listener: _resource_record_pre_action 00:56:30 INFO - Running main action method: read_buildbot_config 00:56:30 INFO - Using buildbot properties: 00:56:30 INFO - { 00:56:30 INFO - "project": "", 00:56:30 INFO - "product": "firefox", 00:56:30 INFO - "who": "cbook@mozilla.com", 00:56:30 INFO - "installer_path": "public/build/target.tar.bz2", 00:56:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 00:56:30 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 00:56:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 00:56:30 INFO - "stage_platform": "linux64", 00:56:30 INFO - "basedir": "/builds/slave/test", 00:56:30 INFO - "buildnumber": 21, 00:56:30 INFO - "platform": "ubuntu64_hw", 00:56:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:56:30 INFO - "slavebuilddir": "test", 00:56:30 INFO - "taskId": "bb_t5s1YQDKeGSoFlbTOHQ", 00:56:30 INFO - "branch": "mozilla-aurora", 00:56:30 INFO - "script_repo_revision": "production", 00:56:30 INFO - "revision": "4116e3e124601c356950880ad01f015626b21345", 00:56:30 INFO - "slavename": "talos-linux64-ix-029", 00:56:30 INFO - "repo_path": "releases/mozilla-aurora" 00:56:30 INFO - } 00:56:30 INFO - Finding installer, test and symbols from parent task. 00:56:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bb_t5s1YQDKeGSoFlbTOHQ'}, attempt #1 00:56:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bb_t5s1YQDKeGSoFlbTOHQ'}, attempt #1 00:56:31 INFO - Task dependencies: UKCxlCurS26kUJ6Jv-tR9g 00:56:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g'}, attempt #1 00:56:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:56:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/test_packages.json 00:56:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.crashreporter-symbols.zip 00:56:31 INFO - Running post-action listener: _resource_record_post_action 00:56:31 INFO - [mozharness: 2017-02-07 08:56:31.904276Z] Finished read-buildbot-config step (success) 00:56:31 INFO - [mozharness: 2017-02-07 08:56:31.904493Z] Running download-and-extract step. 00:56:31 INFO - Running pre-action listener: _resource_record_pre_action 00:56:31 INFO - Running main action method: download_and_extract 00:56:31 INFO - mkdir: /builds/slave/test/build/tests 00:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:31 INFO - trying https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.test_packages.json 00:56:31 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:56:31 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:56:32 INFO - Downloaded 896 bytes. 00:56:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:56:32 INFO - Using the following test package requirements: 00:56:32 INFO - {u'common': [u'target.common.tests.zip'], 00:56:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:56:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:56:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:56:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:56:32 INFO - u'mozbase': [u'target.common.tests.zip'], 00:56:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:56:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:56:32 INFO - u'web-platform': [u'target.common.tests.zip', 00:56:32 INFO - u'target.web-platform.tests.zip'], 00:56:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:56:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 00:56:32 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:56:32 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:56:32 INFO - Fetch https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip into memory 00:56:33 INFO - Expected file size: 21855405 00:56:33 INFO - Obtained file size: 21855405 00:56:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 00:56:37 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:56:37 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:56:37 INFO - Fetch https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.common.tests.zip into memory 00:56:38 INFO - Expected file size: 21855405 00:56:38 INFO - Obtained file size: 21855405 00:56:42 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:56:42 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:56:42 INFO - Fetch https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.talos.tests.zip into memory 00:56:43 INFO - Expected file size: 14403485 00:56:43 INFO - Obtained file size: 14403485 00:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:43 INFO - trying https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:56:43 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:56:43 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:56:44 INFO - Downloaded 66085688 bytes. 00:56:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:56:44 INFO - mkdir: /builds/slave/test/properties 00:56:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:56:44 INFO - Writing to file /builds/slave/test/properties/build_url 00:56:44 INFO - Contents: 00:56:44 INFO - build_url:https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 00:56:44 INFO - Running post-action listener: _resource_record_post_action 00:56:44 INFO - Running post-action listener: set_extra_try_arguments 00:56:44 INFO - [mozharness: 2017-02-07 08:56:44.889581Z] Finished download-and-extract step (success) 00:56:44 INFO - [mozharness: 2017-02-07 08:56:44.889678Z] Running populate-webroot step. 00:56:44 INFO - Running pre-action listener: _resource_record_pre_action 00:56:44 INFO - Running main action method: populate_webroot 00:56:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:56:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:56:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:56:44 INFO - '--tppagecycles', 00:56:44 INFO - '7'], 00:56:44 INFO - 'tests': ['tsvgm']}}, 00:56:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:56:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:56:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:56:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:56:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:56:44 INFO - 'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:56:44 INFO - 'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['damp', 'tps']}, 00:56:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:56:44 INFO - 'tests': ['damp', 'tps']}, 00:56:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['dromaeo_dom']}, 00:56:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:56:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['basic_compositor_video']}, 00:56:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:56:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['a11yr', 00:56:44 INFO - 'ts_paint', 00:56:44 INFO - 'tpaint', 00:56:44 INFO - 'sessionrestore', 00:56:44 INFO - 'sessionrestore_no_auto_restore', 00:56:44 INFO - 'tabpaint']}, 00:56:44 INFO - 'other-e10s': {'tests': ['a11yr', 00:56:44 INFO - 'ts_paint', 00:56:44 INFO - 'tpaint', 00:56:44 INFO - 'sessionrestore', 00:56:44 INFO - 'sessionrestore_no_auto_restore', 00:56:44 INFO - 'tabpaint']}, 00:56:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:56:44 INFO - 'ts_paint', 00:56:44 INFO - 'tpaint', 00:56:44 INFO - 'sessionrestore', 00:56:44 INFO - 'sessionrestore_no_auto_restore', 00:56:44 INFO - 'tabpaint']}, 00:56:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:56:44 INFO - 'ts_paint', 00:56:44 INFO - 'tpaint', 00:56:44 INFO - 'sessionrestore', 00:56:44 INFO - 'sessionrestore_no_auto_restore', 00:56:44 INFO - 'tabpaint']}, 00:56:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['a11yr', 00:56:44 INFO - 'ts_paint', 00:56:44 INFO - 'tpaint', 00:56:44 INFO - 'sessionrestore', 00:56:44 INFO - 'sessionrestore_no_auto_restore', 00:56:44 INFO - 'tabpaint']}, 00:56:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['a11yr', 00:56:44 INFO - 'ts_paint', 00:56:44 INFO - 'tpaint', 00:56:44 INFO - 'sessionrestore', 00:56:44 INFO - 'sessionrestore_no_auto_restore', 00:56:44 INFO - 'tabpaint']}, 00:56:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['tsvgx', 00:56:44 INFO - 'tsvgr_opacity', 00:56:44 INFO - 'tart', 00:56:44 INFO - 'tscrollx', 00:56:44 INFO - 'cart', 00:56:44 INFO - 'tsvg_static']}, 00:56:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:56:44 INFO - 'tsvgr_opacity', 00:56:44 INFO - 'tart', 00:56:44 INFO - 'tscrollx', 00:56:44 INFO - 'cart', 00:56:44 INFO - 'tsvg_static']}, 00:56:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:56:44 INFO - 'talos_options': ['--disable-e10s'], 00:56:44 INFO - 'tests': ['tp5o']}, 00:56:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:56:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:56:44 INFO - 'talos_options': ['--disable-e10s', 00:56:44 INFO - '--xperf_path', 00:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:44 INFO - 'tests': ['tp5n']}, 00:56:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:56:44 INFO - 'talos_options': ['--xperf_path', 00:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:44 INFO - 'tests': ['tp5n']}}, 00:56:44 INFO - 'talos.zip': {'path': '', 00:56:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:56:44 INFO - Running post-action listener: _resource_record_post_action 00:56:44 INFO - [mozharness: 2017-02-07 08:56:44.902889Z] Finished populate-webroot step (success) 00:56:44 INFO - [mozharness: 2017-02-07 08:56:44.902980Z] Running create-virtualenv step. 00:56:44 INFO - Running pre-action listener: _resource_record_pre_action 00:56:44 INFO - Running main action method: create_virtualenv 00:56:44 INFO - Creating virtualenv /builds/slave/test/build/venv 00:56:44 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:56:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:56:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:56:45 INFO - Using real prefix '/usr' 00:56:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:56:45 INFO - Installing distribute.............................................................................................................................................................................................done. 00:56:47 INFO - Installing pip.................done. 00:56:47 INFO - Return code: 0 00:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:56:47 INFO - Reading from file tmpfile_stdout 00:56:47 INFO - Output received: 00:56:47 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:56:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:56:47 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:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 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:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:47 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:56:47 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:56:47 INFO - Using env: {'DISPLAY': ':0', 00:56:47 INFO - 'HOME': '/home/cltbld', 00:56:47 INFO - 'LANG': 'en_US.UTF-8', 00:56:47 INFO - 'LANGUAGE': 'en_US:en', 00:56:47 INFO - 'LOGNAME': 'cltbld', 00:56:47 INFO - 'MAIL': '/var/mail/cltbld', 00:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:47 INFO - 'MOZ_NO_REMOTE': '1', 00:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:47 INFO - 'NO_EM_RESTART': '1', 00:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:47 INFO - 'PWD': '/builds/slave/test', 00:56:47 INFO - 'SHELL': '/bin/bash', 00:56:47 INFO - 'SHLVL': '1', 00:56:47 INFO - 'TERM': 'linux', 00:56:47 INFO - 'TMOUT': '86400', 00:56:47 INFO - 'USER': 'cltbld', 00:56:47 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:47 INFO - '_': '/tools/buildbot/bin/python'} 00:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:47 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:56:47 INFO - Cleaning up... 00:56:47 INFO - Return code: 0 00:56:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:56:47 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:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 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:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:47 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:56:47 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:56:47 INFO - Using env: {'DISPLAY': ':0', 00:56:47 INFO - 'HOME': '/home/cltbld', 00:56:47 INFO - 'LANG': 'en_US.UTF-8', 00:56:47 INFO - 'LANGUAGE': 'en_US:en', 00:56:47 INFO - 'LOGNAME': 'cltbld', 00:56:47 INFO - 'MAIL': '/var/mail/cltbld', 00:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:47 INFO - 'MOZ_NO_REMOTE': '1', 00:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:47 INFO - 'NO_EM_RESTART': '1', 00:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:47 INFO - 'PWD': '/builds/slave/test', 00:56:47 INFO - 'SHELL': '/bin/bash', 00:56:47 INFO - 'SHLVL': '1', 00:56:47 INFO - 'TERM': 'linux', 00:56:47 INFO - 'TMOUT': '86400', 00:56:47 INFO - 'USER': 'cltbld', 00:56:47 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:47 INFO - '_': '/tools/buildbot/bin/python'} 00:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:48 INFO - Downloading/unpacking psutil>=3.1.1 00:56:48 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:48 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:48 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:48 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:48 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:48 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:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:50 INFO - Installing collected packages: psutil 00:56:50 INFO - Running setup.py install for psutil 00:56:50 INFO - building 'psutil._psutil_linux' extension 00:56:50 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:50 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:50 INFO - building 'psutil._psutil_posix' extension 00:56:50 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:50 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:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:50 INFO - Successfully installed psutil 00:56:50 INFO - Cleaning up... 00:56:50 INFO - Return code: 0 00:56:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:56:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:50 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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 00:56:50 INFO - 'HOME': '/home/cltbld', 00:56:50 INFO - 'LANG': 'en_US.UTF-8', 00:56:50 INFO - 'LANGUAGE': 'en_US:en', 00:56:50 INFO - 'LOGNAME': 'cltbld', 00:56:50 INFO - 'MAIL': '/var/mail/cltbld', 00:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:50 INFO - 'MOZ_NO_REMOTE': '1', 00:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:50 INFO - 'NO_EM_RESTART': '1', 00:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:50 INFO - 'PWD': '/builds/slave/test', 00:56:50 INFO - 'SHELL': '/bin/bash', 00:56:50 INFO - 'SHLVL': '1', 00:56:50 INFO - 'TERM': 'linux', 00:56:50 INFO - 'TMOUT': '86400', 00:56:50 INFO - 'USER': 'cltbld', 00:56:50 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:50 INFO - '_': '/tools/buildbot/bin/python'} 00:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:56:51 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:51 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:51 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:51 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:51 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:51 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:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:56:53 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:53 INFO - Installing collected packages: mozsystemmonitor 00:56:53 INFO - Running setup.py install for mozsystemmonitor 00:56:53 INFO - Successfully installed mozsystemmonitor 00:56:53 INFO - Cleaning up... 00:56:53 INFO - Return code: 0 00:56:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:56: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:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:56:53 INFO - Using env: {'DISPLAY': ':0', 00:56:53 INFO - 'HOME': '/home/cltbld', 00:56:53 INFO - 'LANG': 'en_US.UTF-8', 00:56:53 INFO - 'LANGUAGE': 'en_US:en', 00:56:53 INFO - 'LOGNAME': 'cltbld', 00:56:53 INFO - 'MAIL': '/var/mail/cltbld', 00:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:53 INFO - 'MOZ_NO_REMOTE': '1', 00:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:53 INFO - 'NO_EM_RESTART': '1', 00:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:53 INFO - 'PWD': '/builds/slave/test', 00:56:53 INFO - 'SHELL': '/bin/bash', 00:56:53 INFO - 'SHLVL': '1', 00:56:53 INFO - 'TERM': 'linux', 00:56:53 INFO - 'TMOUT': '86400', 00:56:53 INFO - 'USER': 'cltbld', 00:56:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:53 INFO - '_': '/tools/buildbot/bin/python'} 00:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:53 INFO - Downloading/unpacking jsonschema==2.5.1 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:56:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:56:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Downloading functools32-3.2.3-2.tar.gz 00:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:56:55 INFO - warning: no files found matching '*.txt' 00:56:55 INFO - no previously-included directories found matching 'build' 00:56:55 INFO - no previously-included directories found matching 'dist' 00:56:55 INFO - no previously-included directories found matching '.git*' 00:56:55 INFO - Installing collected packages: jsonschema, functools32 00:56:55 INFO - Running setup.py install for functools32 00:56:55 INFO - warning: no files found matching '*.txt' 00:56:55 INFO - no previously-included directories found matching 'build' 00:56:55 INFO - no previously-included directories found matching 'dist' 00:56:55 INFO - no previously-included directories found matching '.git*' 00:56:55 INFO - Successfully installed jsonschema functools32 00:56:55 INFO - Cleaning up... 00:56:55 INFO - Return code: 0 00:56:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:56:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:55 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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:55 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:55 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:56 INFO - Using env: {'DISPLAY': ':0', 00:56:56 INFO - 'HOME': '/home/cltbld', 00:56:56 INFO - 'LANG': 'en_US.UTF-8', 00:56:56 INFO - 'LANGUAGE': 'en_US:en', 00:56:56 INFO - 'LOGNAME': 'cltbld', 00:56:56 INFO - 'MAIL': '/var/mail/cltbld', 00:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:56 INFO - 'MOZ_NO_REMOTE': '1', 00:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:56 INFO - 'NO_EM_RESTART': '1', 00:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:56 INFO - 'PWD': '/builds/slave/test', 00:56:56 INFO - 'SHELL': '/bin/bash', 00:56:56 INFO - 'SHLVL': '1', 00:56:56 INFO - 'TERM': 'linux', 00:56:56 INFO - 'TMOUT': '86400', 00:56:56 INFO - 'USER': 'cltbld', 00:56:56 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:56 INFO - '_': '/tools/buildbot/bin/python'} 00:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:56:56 INFO - Cleaning up... 00:56:56 INFO - Return code: 0 00:56:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:56:56 INFO - Using env: {'DISPLAY': ':0', 00:56:56 INFO - 'HOME': '/home/cltbld', 00:56:56 INFO - 'LANG': 'en_US.UTF-8', 00:56:56 INFO - 'LANGUAGE': 'en_US:en', 00:56:56 INFO - 'LOGNAME': 'cltbld', 00:56:56 INFO - 'MAIL': '/var/mail/cltbld', 00:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:56 INFO - 'MOZ_NO_REMOTE': '1', 00:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:56 INFO - 'NO_EM_RESTART': '1', 00:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:56 INFO - 'PWD': '/builds/slave/test', 00:56:56 INFO - 'SHELL': '/bin/bash', 00:56:56 INFO - 'SHLVL': '1', 00:56:56 INFO - 'TERM': 'linux', 00:56:56 INFO - 'TMOUT': '86400', 00:56:56 INFO - 'USER': 'cltbld', 00:56:56 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:56 INFO - '_': '/tools/buildbot/bin/python'} 00:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:56 INFO - Downloading/unpacking blobuploader==1.2.4 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:58 INFO - Downloading blobuploader-1.2.4.tar.gz 00:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:56:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:56:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:59 INFO - Downloading docopt-0.6.1.tar.gz 00:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:56:59 INFO - Installing collected packages: blobuploader, requests, docopt 00:56:59 INFO - Running setup.py install for blobuploader 00:56:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:56:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:56:59 INFO - Running setup.py install for requests 00:56:59 INFO - Running setup.py install for docopt 00:56:59 INFO - Successfully installed blobuploader requests docopt 00:56:59 INFO - Cleaning up... 00:56:59 INFO - Return code: 0 00:56:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:59 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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 00:56:59 INFO - 'HOME': '/home/cltbld', 00:56:59 INFO - 'LANG': 'en_US.UTF-8', 00:56:59 INFO - 'LANGUAGE': 'en_US:en', 00:56:59 INFO - 'LOGNAME': 'cltbld', 00:56:59 INFO - 'MAIL': '/var/mail/cltbld', 00:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:59 INFO - 'MOZ_NO_REMOTE': '1', 00:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:59 INFO - 'NO_EM_RESTART': '1', 00:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:59 INFO - 'PWD': '/builds/slave/test', 00:56:59 INFO - 'SHELL': '/bin/bash', 00:56:59 INFO - 'SHLVL': '1', 00:56:59 INFO - 'TERM': 'linux', 00:56:59 INFO - 'TMOUT': '86400', 00:56:59 INFO - 'USER': 'cltbld', 00:56:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:59 INFO - '_': '/tools/buildbot/bin/python'} 00:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:57:00 INFO - Running setup.py (path:/tmp/pip-s5cgZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:57:00 INFO - Running setup.py (path:/tmp/pip-vQZHcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:57:00 INFO - Running setup.py (path:/tmp/pip-qzCDzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:57:00 INFO - Running setup.py (path:/tmp/pip-3w7b1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:57:00 INFO - Running setup.py (path:/tmp/pip-OLNY46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:57:00 INFO - Running setup.py (path:/tmp/pip-7NswQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:57:00 INFO - Running setup.py (path:/tmp/pip-IPvGXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:57:00 INFO - Running setup.py (path:/tmp/pip-Gx80U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:57:00 INFO - Running setup.py (path:/tmp/pip-qUZbm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:57:00 INFO - Running setup.py (path:/tmp/pip-54wnaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:57:00 INFO - Running setup.py (path:/tmp/pip-3L9HBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:57:00 INFO - Running setup.py (path:/tmp/pip-eZPt1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:57:00 INFO - Running setup.py (path:/tmp/pip-htsEbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:57:01 INFO - Running setup.py (path:/tmp/pip-nURSy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:01 INFO - Running setup.py (path:/tmp/pip-Lm1AhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:57:01 INFO - Running setup.py (path:/tmp/pip-RfoVSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:57:01 INFO - Running setup.py (path:/tmp/pip-0ea6VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:57:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:57:01 INFO - Running setup.py install for manifestparser 00:57:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:57:01 INFO - Running setup.py install for mozcrash 00:57:01 INFO - Running setup.py install for mozdebug 00:57:01 INFO - Running setup.py install for mozdevice 00:57:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:57:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:57:01 INFO - Running setup.py install for mozfile 00:57:01 INFO - Running setup.py install for mozhttpd 00:57:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:57:01 INFO - Running setup.py install for mozinfo 00:57:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Running setup.py install for mozInstall 00:57:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Running setup.py install for mozleak 00:57:02 INFO - Running setup.py install for mozlog 00:57:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Running setup.py install for moznetwork 00:57:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Running setup.py install for mozprocess 00:57:02 INFO - Running setup.py install for mozprofile 00:57:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Running setup.py install for mozrunner 00:57:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:57:02 INFO - Running setup.py install for mozscreenshot 00:57:02 INFO - Running setup.py install for moztest 00:57:02 INFO - Running setup.py install for mozversion 00:57:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:57:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:57:03 INFO - Cleaning up... 00:57:03 INFO - Return code: 0 00:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:03 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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:57:03 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:57:03 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:57:03 INFO - Using env: {'DISPLAY': ':0', 00:57:03 INFO - 'HOME': '/home/cltbld', 00:57:03 INFO - 'LANG': 'en_US.UTF-8', 00:57:03 INFO - 'LANGUAGE': 'en_US:en', 00:57:03 INFO - 'LOGNAME': 'cltbld', 00:57:03 INFO - 'MAIL': '/var/mail/cltbld', 00:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:03 INFO - 'MOZ_NO_REMOTE': '1', 00:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:03 INFO - 'NO_EM_RESTART': '1', 00:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:03 INFO - 'PWD': '/builds/slave/test', 00:57:03 INFO - 'SHELL': '/bin/bash', 00:57:03 INFO - 'SHLVL': '1', 00:57:03 INFO - 'TERM': 'linux', 00:57:03 INFO - 'TMOUT': '86400', 00:57:03 INFO - 'USER': 'cltbld', 00:57:03 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:03 INFO - '_': '/tools/buildbot/bin/python'} 00:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:57:03 INFO - Running setup.py (path:/tmp/pip-f2klKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:57:03 INFO - Running setup.py (path:/tmp/pip-8ojRyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:57:03 INFO - Running setup.py (path:/tmp/pip-MrCP_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:57:03 INFO - Running setup.py (path:/tmp/pip-KOl6e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:57:03 INFO - Running setup.py (path:/tmp/pip-Pdjm2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:57:03 INFO - Running setup.py (path:/tmp/pip-9DSleZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:57:03 INFO - Running setup.py (path:/tmp/pip-MnEv7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:57:03 INFO - Running setup.py (path:/tmp/pip-8eqDbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:57:03 INFO - Running setup.py (path:/tmp/pip-ebaDhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:57:03 INFO - Running setup.py (path:/tmp/pip-WD3Ji3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:57:04 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:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:57:04 INFO - Running setup.py (path:/tmp/pip-xf5Q_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:57:04 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:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:57:04 INFO - Running setup.py (path:/tmp/pip-uRmdKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:57:04 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:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:57:04 INFO - Running setup.py (path:/tmp/pip-Bd24Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:57:04 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:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:57:04 INFO - Running setup.py (path:/tmp/pip-u2VMzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:57:04 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:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:04 INFO - Running setup.py (path:/tmp/pip-l2gCj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:04 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:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:57:04 INFO - Running setup.py (path:/tmp/pip-LnjQYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:57:04 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:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:57:04 INFO - Running setup.py (path:/tmp/pip-d1uLnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:57:04 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:57:04 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:57:04 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:57:04 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:57:04 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:57:04 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:57:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:57: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:57: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:57: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:57: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:57: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:57: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:57:06 INFO - Downloading blessings-1.6.tar.gz 00:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:57:06 INFO - Installing collected packages: blessings 00:57:06 INFO - Running setup.py install for blessings 00:57:06 INFO - Successfully installed blessings 00:57:06 INFO - Cleaning up... 00:57:06 INFO - Return code: 0 00:57:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:07 INFO - Reading from file tmpfile_stdout 00:57:07 INFO - Current package versions: 00:57:07 INFO - argparse == 1.2.1 00:57:07 INFO - blessings == 1.6 00:57:07 INFO - blobuploader == 1.2.4 00:57:07 INFO - docopt == 0.6.1 00:57:07 INFO - functools32 == 3.2.3-2 00:57:07 INFO - jsonschema == 2.5.1 00:57:07 INFO - manifestparser == 1.1 00:57:07 INFO - mozInstall == 1.12 00:57:07 INFO - mozcrash == 1.0 00:57:07 INFO - mozdebug == 0.1 00:57:07 INFO - mozdevice == 0.49 00:57:07 INFO - mozfile == 1.2 00:57:07 INFO - mozhttpd == 0.7 00:57:07 INFO - mozinfo == 0.9 00:57:07 INFO - mozleak == 0.1 00:57:07 INFO - mozlog == 3.4 00:57:07 INFO - moznetwork == 0.27 00:57:07 INFO - mozprocess == 0.24 00:57:07 INFO - mozprofile == 0.28 00:57:07 INFO - mozrunner == 6.13 00:57:07 INFO - mozscreenshot == 0.1 00:57:07 INFO - mozsystemmonitor == 0.3 00:57:07 INFO - moztest == 0.8 00:57:07 INFO - mozversion == 1.4 00:57:07 INFO - psutil == 3.1.1 00:57:07 INFO - requests == 1.2.3 00:57:07 INFO - wsgiref == 0.1.2 00:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:57: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:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:07 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 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:57:07 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:57:07 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:57:07 INFO - Using env: {'DISPLAY': ':0', 00:57:07 INFO - 'HOME': '/home/cltbld', 00:57:07 INFO - 'LANG': 'en_US.UTF-8', 00:57:07 INFO - 'LANGUAGE': 'en_US:en', 00:57:07 INFO - 'LOGNAME': 'cltbld', 00:57:07 INFO - 'MAIL': '/var/mail/cltbld', 00:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:07 INFO - 'MOZ_NO_REMOTE': '1', 00:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:07 INFO - 'NO_EM_RESTART': '1', 00:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:07 INFO - 'PWD': '/builds/slave/test', 00:57:07 INFO - 'SHELL': '/bin/bash', 00:57:07 INFO - 'SHLVL': '1', 00:57:07 INFO - 'TERM': 'linux', 00:57:07 INFO - 'TMOUT': '86400', 00:57:07 INFO - 'USER': 'cltbld', 00:57:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:07 INFO - '_': '/tools/buildbot/bin/python'} 00:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 INFO - Cleaning up... 00:57:07 INFO - Return code: 0 00:57:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:57: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:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xded1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', '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:57: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', 'jsonschema'] in /builds/slave/test/build 00:57: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 jsonschema 00:57:07 INFO - Using env: {'DISPLAY': ':0', 00:57:07 INFO - 'HOME': '/home/cltbld', 00:57:07 INFO - 'LANG': 'en_US.UTF-8', 00:57:07 INFO - 'LANGUAGE': 'en_US:en', 00:57:07 INFO - 'LOGNAME': 'cltbld', 00:57:07 INFO - 'MAIL': '/var/mail/cltbld', 00:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:07 INFO - 'MOZ_NO_REMOTE': '1', 00:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:07 INFO - 'NO_EM_RESTART': '1', 00:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:07 INFO - 'PWD': '/builds/slave/test', 00:57:07 INFO - 'SHELL': '/bin/bash', 00:57:07 INFO - 'SHLVL': '1', 00:57:07 INFO - 'TERM': 'linux', 00:57:07 INFO - 'TMOUT': '86400', 00:57:07 INFO - 'USER': 'cltbld', 00:57:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:07 INFO - '_': '/tools/buildbot/bin/python'} 00:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:57:07 INFO - Cleaning up... 00:57:07 INFO - Return code: 0 00:57:07 INFO - Running post-action listener: _resource_record_post_action 00:57:07 INFO - Running post-action listener: _start_resource_monitoring 00:57:07 INFO - Starting resource monitoring. 00:57:07 INFO - [mozharness: 2017-02-07 08:57:07.518270Z] Finished create-virtualenv step (success) 00:57:07 INFO - [mozharness: 2017-02-07 08:57:07.518760Z] Running install step. 00:57:07 INFO - Running pre-action listener: _resource_record_pre_action 00:57:07 INFO - Running main action method: install 00:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:07 INFO - Reading from file tmpfile_stdout 00:57:07 INFO - Detecting whether we're running mozinstall >=1.0... 00:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:57:07 INFO - Reading from file tmpfile_stdout 00:57:07 INFO - Output received: 00:57:07 INFO - Usage: mozinstall [options] installer 00:57:07 INFO - Options: 00:57:07 INFO - -h, --help show this help message and exit 00:57:07 INFO - -d DEST, --destination=DEST 00:57:07 INFO - Directory to install application into. [default: 00:57:07 INFO - "/builds/slave/test"] 00:57:07 INFO - --app=APP Application being installed. [default: firefox] 00:57:07 INFO - mkdir: /builds/slave/test/build/application 00:57:07 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:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:57:24 INFO - Reading from file tmpfile_stdout 00:57:24 INFO - Output received: 00:57:24 INFO - /builds/slave/test/build/application/firefox/firefox 00:57:24 INFO - Running post-action listener: _resource_record_post_action 00:57:24 INFO - [mozharness: 2017-02-07 08:57:24.271843Z] Finished install step (success) 00:57:24 INFO - [mozharness: 2017-02-07 08:57:24.271991Z] Running run-tests step. 00:57:24 INFO - Running pre-action listener: _resource_record_pre_action 00:57:24 INFO - Running main action method: run_tests 00:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:57:24 INFO - Python 2.7.3 00:57:24 INFO - Return code: 0 00:57:24 INFO - grabbing minidump binary from tooltool 00:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:24 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 0x115cd00>, '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 0x115da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115deb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:57:24 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:57:24 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:57:24 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:57:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:57:24 INFO - Return code: 0 00:57:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:57:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:57:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:57:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:57:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:57:24 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', '--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-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:57:24 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 --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-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:57:24 INFO - Using env: {'DISPLAY': ':0', 00:57:24 INFO - 'HOME': '/home/cltbld', 00:57:24 INFO - 'LANG': 'en_US.UTF-8', 00:57:24 INFO - 'LANGUAGE': 'en_US:en', 00:57:24 INFO - 'LOGNAME': 'cltbld', 00:57:24 INFO - 'MAIL': '/var/mail/cltbld', 00:57:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:57:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:24 INFO - 'MOZ_NO_REMOTE': '1', 00:57:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:24 INFO - 'NO_EM_RESTART': '1', 00:57:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:24 INFO - 'PWD': '/builds/slave/test', 00:57:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:57:24 INFO - 'SHELL': '/bin/bash', 00:57:24 INFO - 'SHLVL': '1', 00:57:24 INFO - 'TERM': 'linux', 00:57:24 INFO - 'TMOUT': '86400', 00:57:24 INFO - 'USER': 'cltbld', 00:57:24 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334', 00:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:24 INFO - '_': '/tools/buildbot/bin/python'} 00:57:24 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', '--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-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:57:24 INFO - mozversion application_buildid: 20170207075830 00:57:24 INFO - mozversion application_changeset: 4116e3e124601c356950880ad01f015626b21345 00:57:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:57:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:57:24 INFO - mozversion application_name: Firefox 00:57:24 INFO - mozversion application_remotingname: firefox-dev 00:57:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:57:24 INFO - mozversion application_vendor: Mozilla 00:57:24 INFO - mozversion application_version: 53.0a2 00:57:24 INFO - mozversion platform_buildid: 20170207075830 00:57:24 INFO - mozversion platform_changeset: 4116e3e124601c356950880ad01f015626b21345 00:57:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:57:24 INFO - mozversion platform_version: 53.0a2 00:57:24 INFO - using testdate: 1486457844 00:57:24 INFO - actual date: 1486457844 00:57:24 INFO - starting webserver on 'localhost:43087' 00:57:24 INFO - SUITE-START | Running 2 tests 00:57:24 INFO - TEST-START | dromaeo_css 00:57:24 INFO - operating with platform_type : linux_ 00:57:24 INFO - Initialising browser for dromaeo_css test... 00:57:24 INFO - TEST-INFO | started process 17021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDpJxZ8/profile http://localhost:43087/getInfo.html) 00:57:28 INFO - PROCESS | 17021 | __metrics Screen width/height:1600/1200 00:57:28 INFO - PROCESS | 17021 | colorDepth:24 00:57:28 INFO - PROCESS | 17021 | Browser inner width/height: 1024/697 00:57:28 INFO - PROCESS | 17021 | __metrics 00:57:29 INFO - PROCESS | 17021 | 1486457849376 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 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 00:57:29 INFO - PROCESS | 17021 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:57:29 INFO - PROCESS | 17021 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:57:30 INFO - PROCESS | 17021 | console.error: PushService: 00:57:30 INFO - PROCESS | 17021 | stateChangeProcessEnqueue: Error transitioning state 00:57:30 INFO - PROCESS | 17021 | UnknownError 00:57:30 INFO - TEST-INFO | 17021: exit 0 00:57:30 INFO - Browser initialized. 00:57:30 INFO - Running cycle 1/1 for dromaeo_css test... 00:57:30 INFO - TEST-INFO | started process 17112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDpJxZ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:42 INFO - PROCESS | 17112 | RSS: Main: 138412032 00:57:42 INFO - PROCESS | 17112 | 01:00:42 INFO - PROCESS | 17112 | Cycle 1(1): loaded http://localhost:43087/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43087/tests/dromaeo/cssquery-ext.html) 01:00:43 INFO - PROCESS | 17112 | RSS: Main: 235278336 01:00:43 INFO - PROCESS | 17112 | 01:02:32 INFO - PROCESS | 17112 | ************************* 01:02:32 INFO - PROCESS | 17112 | A coding exception was thrown and uncaught in a Task. 01:02:32 INFO - PROCESS | 17112 | 01:02:32 ERROR - PROCESS | 17112 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:02:32 INFO - PROCESS | 17112 | Full stack: 01:02:32 INFO - PROCESS | 17112 | ************************* 01:03:46 INFO - PROCESS | 17112 | Cycle 1(1): loaded http://localhost:43087/tests/dromaeo/cssquery-ext.html (next: http://localhost:43087/tests/dromaeo/cssquery-jquery.html) 01:03:46 INFO - PROCESS | 17112 | RSS: Main: 221609984 01:03:46 INFO - PROCESS | 17112 | 01:06:48 INFO - PROCESS | 17112 | Cycle 1(1): loaded http://localhost:43087/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43087/tests/dromaeo/cssquery-mootools.html) 01:06:49 INFO - PROCESS | 17112 | RSS: Main: 170840064 01:06:49 INFO - PROCESS | 17112 | 01:09:51 INFO - PROCESS | 17112 | Cycle 1(1): loaded http://localhost:43087/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43087/tests/dromaeo/cssquery-prototype.html) 01:09:51 INFO - PROCESS | 17112 | RSS: Main: 220336128 01:09:51 INFO - PROCESS | 17112 | 01:12:54 INFO - PROCESS | 17112 | Cycle 1(1): loaded http://localhost:43087/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43087/tests/dromaeo/cssquery-yui.html) 01:12:54 INFO - PROCESS | 17112 | RSS: Main: 172572672 01:12:54 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | Cycle 1(1): loaded http://localhost:43087/tests/dromaeo/cssquery-yui.html (next: http://localhost:43087/tests/dromaeo/cssquery-dojo.html) 01:15:57 INFO - PROCESS | 17112 | RSS: Main: 260468736 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | __start_tp_report 01:15:57 INFO - PROCESS | 17112 | _x_x_mozilla_page_load 01:15:57 INFO - PROCESS | 17112 | _x_x_mozilla_page_load_details 01:15:57 INFO - PROCESS | 17112 | |i|pagename|runs| 01:15:57 INFO - PROCESS | 17112 | |0;dojo.html;3250.7236884864787;3252.869885204592;3289.8190599517015;3305.3224089061746;3310;5346.224797404374;5399.028174928511;5409.513143817051;5423.186522021689;5441.183822426638;5442.755076021579;5468.808591699291;5480.725963701819;5484.862878428041;5490.615656904019;4872.658913876021;4885.584725298354;4920.065187614359;4949.406071271453;4970.2296144097545;4770.332153498513;4904.754762261872;4953.628477864157;4960.7767650455635;4988.850334489953;4736.668433209659;4740.07568524138;4767.04659068186;4770.4275486941615;4844.636652251078;4833.516648335173;4865.3675022247235;4871.561559459666;4876.756162191894;4892.266160075981;4764.976175119103;4812.326274321597;4816.181249187646;4842.055799119174;4843.927341089887;5184.662996905189;5280.683159010472;5316.521513063804;5368.30212072432;5369.275147855029;5814.592978491507;5816.9820281451;5819.854503637401;5822.359540450547;5834.212381328509;5848.064309710426;5870.941290587082;5871.383504731984;5903;5903.026000709878;5235.58115350771;5272.393674727378;5287.656302340336;5303.946960530346;5463.672179669233;5808.273965754281;5808.564357673107;5815.79644712433;5832.650040997553;5853;5595.776168953196;5602.915956260659;5603.10350343943;5604.943950560524;5608.270924779753;5588.105903055492;5622.269105016322;5625;5664.376918538957;5675.943240567624;5685.289338832646;5687.146927960839;5699.629524080921;5720.570957178145;5729.742161602738;5699.401562835926;5746.396628354046;5746.770129194785;5751.884962300731;5762.711864406763;4224.408582798349;4238.936415953764;4407.162639098561;4409.603135717801;4445.5776701213335;3936.9015774605864;3967.563568007517;3972.4239985201984;3998.300297447935;4014.197160567898;5639.436056394327;5645.350784659735;5646.8023619173955;5656.717164141776;5667.3482549507335;5584.776608935678;5622;5665.065264231438;5843.328017277982;5846.970765146232;5531.9723401382735;5586.497215250647;5588.860278492989;5620.353659329147;5623.015972204929;4942.950570494321;4947.48051454592;4950.232713929347;4950.331705219749;4980.178270585386;5895.67573783446;5922.289325280908;5925.911111333334;5963;5984.521238300926;5655.547556195576;5689.317281926195;5700.515456186271;5754.6547207167705;5788.681622510634;5968.820935371946;5983.162357269899;5987.251593550806;5994.100884867305;5997.460228579449;5657.264555607745;5657.85855353603;5662.065759149859;5662.348829884616;5664;5606.971965140148;5630.042892708331;5642.943570564242;5691.373948865705;5694.544436444991;5564.1931919870585;5604;5608.242887210175;5617.9719101404235;5638.689872057076;5607.186957891001;5611.298587676541;5612.298462692163;5613.129964855454;5615.298087739033;5376.677399356051;5392.325959255093;5515.972420137874;5551.916721249104;5597.80407685729;5649.096144616841;5656.547476201812;5656.660600363992;5684.488396044376;5688.40271771458;5524.254225679482;5526.392096869261;5532.861678458071;5533.861653458695;5534.39121696605 01:15:57 INFO - PROCESS | 17112 | |1;ext.html;557.7022278890047;582.6300299309938;612.3172662481331;636.4208570201118;646.3019938466457;37034.62965370346;47442;49055.50944490554;49081.263781043315;49166;51824;52125;52393.47606523934;52473.73763131189;52527.47472525274;8949.239314658262;9469.85795213074;9638.277129215337;9659.951700241489;9667.984861589537;8935.55322233889;10365.326253793517;10560.207984401162;10578.047975682188;10956.12351011917;10466.581336746522;10495.79008419835;10511.316764410327;10514.211434142431;10518.579256829718;11798.764024719501;11818.822717659243;11878.762424751543;11899.940500297529;11899.940500297529;11782.175247732663;11857.169998100137;11868.169228154033;11870.465829037714;11879.168458207929;48947.755261223465;49113.754431227615;49271;49318.50681493211;49380.50619493831;4542.500324964251;4551.317302404633;4636.907261854778;4709.789041737924;4724.5984091352275;35098.824505877565;35845.64154358449;36007.81996090029;36470.63529364699;37874;4673.649476289258;4709.364235828154;4731.7634118293945;4743.501932297094;4772.141014617368;360781.9999999974;361330;361411;362956;363349;71708.64145679238;71909;72321.63839180875;72367.27632723711;72415.27584724191;76873;77377.61311193409;77379;77599.61200194075;77709.6114519435;19767.209311627663;20280.797192028185;20309.492262693257;20315.796842031687;20324.288649897182;14315.28423578817;14542.127472351693;15394.461193858162;15747.527574172793;15850.44523441674;19607.411777646408;20516;20650.17399304011;20688.58622827565;20743.066562004748;6268.153799237136;6288.182536270256;6320.6094659174905;6457;6539.692061587702;980.7204946590188;989.3371441134457;997.33677104726;1000.9399436033862;1013.0325539110132;35150.29699405997;35274.34111025721;35473.46789798155;35725.64274357223;35853.35470711154;1092.6667366453307;1140.931544107356;1145.8624965004087;1164.2897832322276;1191.7497325561555;18309.633807324044;18563.90718046401;18644.906775466035;19045.142968566448;19050.61898762017;495923;499674;501601;502147;502214;72762.27237727556;72920;73037.26962730305;73117.6344118276;73206;1472.3668822406469;1531.5788158256569;1534.9923250383677;1539.4227164813194;1545.63677535779;32646.51030234501;34193.31613367768;34589.65410345864;34607.30785384329;34805.303893922486;60859.39140608537;61455.38544614497;61466;61559;61569;374626;374789;374895;375847;376596;40998.95005249785;41071.38392924049;45114.77442612766;45798;46692.7665361671;49976.500234997184;50565.49434505755;50874;51146;51159.69781359773;41334.586654133076;41615.7919210402;41755;41945.37081943834;43603.345949810144;42311.7884410576;42597.36103958505;42933.785331073144;43471;43730.78134609306;41740.582594174884;41783.582164179184;41945.37081943712;42425.78787106045;42489.36265955951;35420.82289588536;37180.44229336616;37281.254374911805;37498.43752343662;38130.61869381271;27633.86183069072;27824;27970.160895173176;28034.579481308203;28072.71927280701 01:15:57 INFO - PROCESS | 17112 | |2;jquery.html;396.4271627498265;407.3197759741233;407.50479780164494;422.73367778299666;435.4143676754764;19878.40364789057;20796.16815327385;21972.8901355493;22067.668984965218;22299.21952731655;22329.10683572655;24286.87856560715;24678;24796.380090497747;26057.73942260577;6704.832379190522;6902.689378977958;7000.859982800341;7002.929970700304;7140.393066589346;6964.338387853171;6991.755288564901;7033.8593228135405;7033.894491582605;7042.82392940178;6859.142607174103;6943.51395402322;6964.512484126113;7026.578405295673;7030.894536581955;6837.487188460886;7006.859862802716;7031.929680703204;7082.185548661892;7083.043789088459;6811.829704257384;6834.2482326944;6842.931570684279;6847.1783385994;6847.93152068478;29746.174113459187;29955.850220748758;30600;30669.539956900666;30915.22711932197;3543.114221444639;3564.4296912494137;3583.068402215417;3658.3414985302634;3680.0615842959874;14171.716565668628;17040.573985650335;17491.650166996715;17668.381606643707;18727.812721872742;2143.4427048967223;2160.2007257314735;2221.8444708870384;2235.9776402235934;2271.2958982715245;85918.57040714819;94015.05984940131;103458.99999999924;117457;119067;20415.285465008652;20435.693464598044;20719.792802072086;20990.580188396147;21367.78632213689;40270;40316;40377.596224037385;40716.38925416121;41049.38425923613;8916.777080573038;9142.3600347975;9335.113164249386;9579.425234485952;11771.058315334752;9374.718758437259;9379.859302110473;9401.57692903821;9413.435193888252;9606.991265917119;5199.896002079937;5202.3497062867145;5221.660592061504;5231.110711179109;5246.3704355477585;2051.5178932950744;2086.5201003768916;2106.789321067881;2120.1731324783345;2153.1817909194406;924.58393722825;937.3110763588757;943.1841457139525;946.4037656276502;948.6774496671165;19103.904480477788;20754.377368678965;22289.88855055747;22956.770432295463;23299.7670023301;1046.2571574182416;1067.594314160614;1070.662741236508;1081.0648788797791;1085.4572713643179;11456.59901903446;11591.6522504325;11667.59163429276;11731.47208375625;11793.88206117945;311975;312700;313257;645207;676880;78219.60890195513;89207;92165;105547.4722626382;107085.46457267819;1176.9470373833199;1178.6798785360452;1223.5289413575838;1228.416502161466;1230.1573422205818;19227.327043553407;19562.413127606196;19581.902090489457;19693.901530492254;19695.409137725892;45642.543574565156;45694.314585281914;46289.3056604158;46802.53197467982;48034.519654804404;63259.36740632719;63314.05028924662;63462.365376345646;64594;65815.34184658092;9020;9194;9228.169464747936;9279.257659387098;9368.4378937264;10110.545025473724;14258.215798131203;14745.852541474447;15051.698966020836;15080.622984425478;10826.837597436202;12279.44742486608;12368.628941131781;12432.502699892264;12773.55292564793;11985.22096063753;12183.695407614881;12622.305773182563;12648.557300494807;12694.555690550786;12382.318972456602;12524.49902003946;12740.299283539494;12810.935945320587;12832.294223817406;9123.315751318545;9290.814183716422;9351.672691455766;9431.858522122311;9646.324757267204;8860.822783544421;11721.648350549498;12108.455119519818;12147.817782733442;12245.081618878441 01:15:57 INFO - PROCESS | 17112 | |3;mootools.html;1479.5561331600518;1492.395579790185;1501.932413041413;1502.2563830903705;1504.6464080940978;8149.225823546761;8690.652373905044;8693.782655433617;8695.565221738903;8695.869561956575;7487.9251207487905;7739.883901741464;8259.545724985124;8429.409941304097;8445.451045682026;2363.3500787283506;2388.176079252655;2402.2072716003677;2402.903883844644;2406.867622280774;2318.7565305642916;2359.7758212969825;2360.7639236076343;2368.100121953655;2369.609014512603;2380.4048987753063;2394.1740099665676;2400.459896523286;2409.156795121702;2437.1835435129165;2159.028437203257;2182.1707751054655;2196.3959911024435;2199.7690242524623;2286.0627142871426;2298.1496846166856;2347.061175529802;2350.576896158691;2350.9882450587806;2352.447174913911;8600.397972141953;8654.134586541295;8663.95668021656;8676.913230867736;8679.088695686989;4907.141250281186;5022.196448568212;5084.51697088776;5161.845144645667;5163.199704045879;3257.755668324885;3335.0661814691925;3370.6292307846115;3397.2016576104597;3401.7958922464486;1322.3322222277784;1345.7039451320693;1390.5967269491834;1404.557564367221;1404.712034033031;11527.308361498337;11568.479418426106;11579.594714184963;11580.76838463226;11648.883511164864;4455.952851079994;4532.297493888453;4542.386777785023;4584.701994370355;4645.349651048856;9965.053319934595;9971.900280997097;9991.850122248172;10000.099991000845;10006;5308.0710875596615;5312.787488500417;5313.468653134733;5314.415414304423;5316.016536940679;4240.38514415408;4358.193734159191;4860.416749989953;4866;4969.453360130383;3920.137569734654;3979.3434083376496;4035.2534781065597;4066.552679205285;4101.671866250693;1248.1574936917543;1255.1402289431585;1256.8994480441543;1260.684828792802;1268.1123213750411;991.5984026469291;1008.5058321422597;1009.6264382178641;1014.1278500489573;1014.1937159957852;5700.258966334433;5749.741261643236;5815.9709201453725;5829.125631155361;5850.444207800252;1029.6396261308632;1031;1041.1358572384902;1043.8517630606273;1058.2063452410691;3971.8808435746973;4055.4525139105845;4097.610726980932;4171.958280417218;4190.371444283321;9966.651167209113;10219.795604088025;10264.948675256725;10285.845712314322;10306.536205870754;10078.032796681466;10180.440075795903;10200;10203.03071208234;10213.08082272599;8079.9192008080345;8122.553259570662;8236.258736713604;8236.464629799044;8246.09292977784;5870.706464676664;5879.764809407576;5930.881382372242;5973.940260597338;6033.637981720935;9401.623935042522;9403.85894211601;9418.95290523543;9439.244860411289;9507.477088760184;9281.767955801159;9733.464659443798;9758.170555502862;9766.706998789763;9775.706728798148;6660.83347916306;6789.083473730983;6792.66036698173;7275.854482910207;7411.481196316422;7716.884246736416;8019.799505012421;8226.341892648694;8292.58537073156;8316.334693224406;7295.343419092307;7630.618469076413;7683.270089341504;7811.960940195263;7838.490498117832;7634.8091297718;7694.846103078019;7758.7672369829;7762.340201082745;7904.13054563986;6435.51733619971;6546.410823025951;6613.702383392855;6614.206295244409;6616.305287944697;5170.302009228856;5216.217567364925;5231.692076980755;5239.109351410193;5266.578673706171;5328.467153284795;5333.040052790535;5362.65142765719;5420.268263784496;5455.1271796512365 01:15:57 INFO - PROCESS | 17112 | |4;prototype.html;391.66903966148595;401.2817057467134;403.3707416430368;410.44179915315186;411.8249743858863;5300.602454815889;5322.6427261048475;5334.759935802888;5378.139497680372;5385.81149659762;5059.949400505994;5155.329807125077;5172.09488339541;5175.170373923298;5286.074936886049;3742.8502859885707;4063.6952228582827;4131.855385061531;4142.357934520154;4164.666826653875;4137.8758637240935;4138.882501724547;4145.0880806222585;4171.791410429481;4187.183499217654;4161.708680392374;4170.812313445887;4179.164167166578;4183.142455796569;4186.665066794664;4022.275990321741;4172.269852775752;4182.2890108681595;4190.078182799794;4220;3851.094992676719;3861.7296789224765;3862.246861861938;3865.7100717446306;3900.317444447239;5148.433672296044;5196.53231209193;5215.6349055566125;5220.8694782630355;5253.317068781034;4833.903321933577;4837;4955;4957.256411538262;4963.975180124113;5493.2034854946205;5510.91733623996;5512.724363781795;5551.8889622207735;5560.888782224333;4263.976645605064;4278.743275403485;4279.679024073207;4281.871543853689;4310.762908040057;5316.20256961455;5494.478024587658;5690.886182276331;5706.457886500776;5751.281089863767;4313.805878735465;4330.112326972963;4333.544977777288;4357.782110894443;4366.4238099521435;4399.12017596482;4400.141972315368;4403.141387429485;4409.316555933835;4439.8002089905385;4772.809087636525;4802.975985120122;4883.121038213085;4897.657163998486;4898.975505122523;5536.640118392292;5539.972300138474;5549.250851135045;5555.194496797942;5564.666120032811;1454.701786133861;1463.9386444827628;1478.2608695652175;1480.2302802542617;1484.1762821634097;1031.9577227000784;1081.1512962324537;1092.6558134187705;1099.2415233488866;1100.1638754546443;5320.680759154463;5325.707086110224;5346.839594812084;5351.812686555952;5384.6769193848495;5447.319085114361;5463.9180412293845;5478.890422191534;5483.862903427446;5489.533389661844;5164.535191832753;5259.868503287372;5291.841244762663;5475.425080366584;5526.723663816793;2942.4997750382486;2944.2050646325374;2956.4678357895787;2957.5563665450354;2961.8667159977854;5598.040685759952;5755.85610359736;5784.219130417424;5795.971020144872;5802.274715660543;5448.891022179534;5470.425605311465;5523.226748255248;5534.335879694382;5665.677072400378;5604.41153678866;5672.12082127271;5677.091665333527;5679.460451257124;5696.629719068247;5335.91705455773;5440.82367053166;5448.536874365724;5479.917801233064;5494.697791621339;5391.9460805391445;5422.457754224546;5423.755930983037;5431.5926305526455;5439.5920305978;5595.944040559542;5680.488756011979;5724.169995350734;5832.358440571618;5844.883102337844;4113.01287690958;4132.297509423465;4144.70987030905;4165.437665915063;4175.665946724315;5552.916706249329;5624.015797235549;5674.240985294572;5691.800786972436;5694.487496125369;5416.9729151353995;5435.592330575144;5454.91817622728;5480.177973304037;5485.177223416519;5486.067368547437;5497.972510137423;5499.532539734168;5509.237044145835;5513.61404701667;5347.144456886879;5471.972640136773;5488.890222195454;5510.201020852034;5547;5429.918551221655;5502.844402675323;5560.221568980265;5561.888762224652;5565.833025009256;5292.911846017114;5349.331333583302;5351.538292385546;5368.489993450616;5372.919406208832 01:15:57 INFO - PROCESS | 17112 | |5;yui.html;816.4325793573465;838.4675730910877;845.868890322;929.9674511392103;943.6932996776047;16649.500514984557;17441.12794360283;18560.814391856093;18604.720929186074;18613.44159675212;16184.514464566053;16648.66702665946;16803.0758308293;16913.154342282898;16957.32170713173;816.1797393619419;830.5847076461769;832.6960659359321;833.0253603284142;833.6707000734706;702.0767690487019;708.4014008163094;832.7501749475133;834.0033659776569;834.2741814621257;845.0450990380891;852.6205838401913;870.7039606533777;874.2394117118116;874.8119154381807;852.2840813716446;852.5864955496579;853.6798700487317;855.8972923249219;858.7295002074327;542.4900593442152;544.042485226005;614.9508039356841;615.3508049008294;615.4491729901713;16601.91699041509;17042.74435883463;17062.14689265544;17074.31702731889;17194.828051719447;16540.6691866162;16883.746743798853;17052.658946821117;17285.740713889303;17550.122493875384;13477.326133693276;13499.392527336195;13544.187348759007;13738.931305343509;13741.450341986309;4004.5194576650697;4033.1530378620523;4089.3457046872654;4104.240715467648;4121.093359460914;79815;80710;81639;83231.99999999939;83864.16135838625;12440.319618839681;12458.563950261878;12693.555725549562;12717.55488557896;12844.229346239255;25263.494730105296;25324;25428.237152885442;25734.871325643253;25913.481730365664;9195.172434480928;9235.815283694423;9364.391314564531;9369.344145909858;9386.67146649864;4557.544245575482;4579.274220749569;4605.40129783126;4700.929486057712;4717.504662010508;3841.558220804643;3917.7845218512684;3960.801959902051;3966.1671049080014;3998.480197574355;608.1121562518772;610.2128254551667;617.2685367839125;618.1099217127322;626.9655168965751;694.6040756768695;697.7767114523303;708.624429052603;714.4070421550101;715.6099925540593;10515.84226236607;10622.94688526568;11123.944380278046;11136.610218642309;11273;737.178046478173;769.6536558548676;839.5927974932154;847.1951645936385;877.2280393253895;5382.138857782736;5390.892182156414;5502.257195278667;5728.198052272685;5733.684647344436;71617;75517;75869.62065189639;78241;78303.21696782959;67161.66419167873;67465.3253467459;67775.32224677788;68623.65688171628;69002.30997689959;60373.39626603766;60401.39598604046;60457.69771151116;60513.69743151256;60524.39475605276;10770.892291076989;10809.729756756144;11046.392448415414;11170.441477926233;11189.944050279697;41831.7908410456;42244;42657;43252.78373608112;43363.56636433722;51235.487645124565;53327.46672533225;53769.19346209732;53952.19071714006;54018.729906350214;12839.422225999666;13238.273026969227;13350.132241404277;13404.128731632412;13492.392842321922;13579.456821727415;13853.792193117313;13867.653308667364;13932.30338483092;13974;13000.219986800823;13213;13313.66715832112;13564.253966031569;13574.467663073014;13983.091099078527;14092.718145636825;14113.929430352782;14131.788023179455;14226.502072427415;13604;14491.044298736877;14969.476068337555;15042.32309546095;15252.084874907541;11947.223430476992;12018.459169337226;12211.328376939353;12348.259104453762;12765.553205637758;11661.76676466483;11797.823032654345;11944.402779860799;11977.880221198026;13113.508433397625 01:15:57 INFO - PROCESS | 17112 | __end_tp_report 01:15:57 INFO - PROCESS | 17112 | __start_cc_report 01:15:57 INFO - PROCESS | 17112 | _x_x_mozilla_cycle_collect,878 01:15:57 INFO - PROCESS | 17112 | __end_cc_report 01:15:57 INFO - PROCESS | 17112 | __startTimestamp1486458957539__endTimestamp 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | ------- Summary: start ------- 01:15:57 INFO - PROCESS | 17112 | Number of tests: 6 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | [#0] dojo.html Cycles:165 Average:5344.39 Median:5602.92 stddev:590.23 (10.5%) stddev-sans-first:568.73 01:15:57 INFO - PROCESS | 17112 | Values: 3250.7 3252.9 3289.8 3305.3 3310.0 5346.2 5399.0 5409.5 5423.2 5441.2 5442.8 5468.8 5480.7 5484.9 5490.6 4872.7 4885.6 4920.1 4949.4 4970.2 4770.3 4904.8 4953.6 4960.8 4988.9 4736.7 4740.1 4767.0 4770.4 4844.6 4833.5 4865.4 4871.6 4876.8 4892.3 4765.0 4812.3 4816.2 4842.1 4843.9 5184.7 5280.7 5316.5 5368.3 5369.3 5814.6 5817.0 5819.9 5822.4 5834.2 5848.1 5870.9 5871.4 5903.0 5903.0 5235.6 5272.4 5287.7 5303.9 5463.7 5808.3 5808.6 5815.8 5832.7 5853.0 5595.8 5602.9 5603.1 5604.9 5608.3 5588.1 5622.3 5625.0 5664.4 5675.9 5685.3 5687.1 5699.6 5720.6 5729.7 5699.4 5746.4 5746.8 5751.9 5762.7 4224.4 4238.9 4407.2 4409.6 4445.6 3936.9 3967.6 3972.4 3998.3 4014.2 5639.4 5645.4 5646.8 5656.7 5667.3 5584.8 5622.0 5665.1 5843.3 5847.0 5532.0 5586.5 5588.9 5620.4 5623.0 4943.0 4947.5 4950.2 4950.3 4980.2 5895.7 5922.3 5925.9 5963.0 5984.5 5655.5 5689.3 5700.5 5754.7 5788.7 5968.8 5983.2 5987.3 5994.1 5997.5 5657.3 5657.9 5662.1 5662.3 5664.0 5607.0 5630.0 5642.9 5691.4 5694.5 5564.2 5604.0 5608.2 5618.0 5638.7 5607.2 5611.3 5612.3 5613.1 5615.3 5376.7 5392.3 5516.0 5551.9 5597.8 5649.1 5656.5 5656.7 5684.5 5688.4 5524.3 5526.4 5532.9 5533.9 5534.4 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | [#1] ext.html Cycles:180 Average:61406.69 Median:41678.19 stddev:109847.45 (263.6%) stddev-sans-first:110060.59 01:15:57 INFO - PROCESS | 17112 | Values: 557.7 582.6 612.3 636.4 646.3 37034.6 47442.0 49055.5 49081.3 49166.0 51824.0 52125.0 52393.5 52473.7 52527.5 8949.2 9469.9 9638.3 9660.0 9668.0 8935.6 10365.3 10560.2 10578.0 10956.1 10466.6 10495.8 10511.3 10514.2 10518.6 11798.8 11818.8 11878.8 11899.9 11899.9 11782.2 11857.2 11868.2 11870.5 11879.2 48947.8 49113.8 49271.0 49318.5 49380.5 4542.5 4551.3 4636.9 4709.8 4724.6 35098.8 35845.6 36007.8 36470.6 37874.0 4673.6 4709.4 4731.8 4743.5 4772.1 360782.0 361330.0 361411.0 362956.0 363349.0 71708.6 71909.0 72321.6 72367.3 72415.3 76873.0 77377.6 77379.0 77599.6 77709.6 19767.2 20280.8 20309.5 20315.8 20324.3 14315.3 14542.1 15394.5 15747.5 15850.4 19607.4 20516.0 20650.2 20688.6 20743.1 6268.2 6288.2 6320.6 6457.0 6539.7 980.7 989.3 997.3 1000.9 1013.0 35150.3 35274.3 35473.5 35725.6 35853.4 1092.7 1140.9 1145.9 1164.3 1191.7 18309.6 18563.9 18644.9 19045.1 19050.6 495923.0 499674.0 501601.0 502147.0 502214.0 72762.3 72920.0 73037.3 73117.6 73206.0 1472.4 1531.6 1535.0 1539.4 1545.6 32646.5 34193.3 34589.7 34607.3 34805.3 60859.4 61455.4 61466.0 61559.0 61569.0 374626.0 374789.0 374895.0 375847.0 376596.0 40999.0 41071.4 45114.8 45798.0 46692.8 49976.5 50565.5 50874.0 51146.0 51159.7 41334.6 41615.8 41755.0 41945.4 43603.3 42311.8 42597.4 42933.8 43471.0 43730.8 41740.6 41783.6 41945.4 42425.8 42489.4 35420.8 37180.4 37281.3 37498.4 38130.6 27633.9 27824.0 27970.2 28034.6 28072.7 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | [#2] jquery.html Cycles:180 Average:31118.24 Median:312337.50 stddev:80457.32 (25.8%) stddev-sans-first:80649.96 01:15:57 INFO - PROCESS | 17112 | Values: 396.4 407.3 407.5 422.7 435.4 19878.4 20796.2 21972.9 22067.7 22299.2 22329.1 24286.9 24678.0 24796.4 26057.7 6704.8 6902.7 7000.9 7002.9 7140.4 6964.3 6991.8 7033.9 7033.9 7042.8 6859.1 6943.5 6964.5 7026.6 7030.9 6837.5 7006.9 7031.9 7082.2 7083.0 6811.8 6834.2 6842.9 6847.2 6847.9 29746.2 29955.9 30600.0 30669.5 30915.2 3543.1 3564.4 3583.1 3658.3 3680.1 14171.7 17040.6 17491.7 17668.4 18727.8 2143.4 2160.2 2221.8 2236.0 2271.3 85918.6 94015.1 103459.0 117457.0 119067.0 20415.3 20435.7 20719.8 20990.6 21367.8 40270.0 40316.0 40377.6 40716.4 41049.4 8916.8 9142.4 9335.1 9579.4 11771.1 9374.7 9379.9 9401.6 9413.4 9607.0 5199.9 5202.3 5221.7 5231.1 5246.4 2051.5 2086.5 2106.8 2120.2 2153.2 924.6 937.3 943.2 946.4 948.7 19103.9 20754.4 22289.9 22956.8 23299.8 1046.3 1067.6 1070.7 1081.1 1085.5 11456.6 11591.7 11667.6 11731.5 11793.9 311975.0 312700.0 313257.0 645207.0 676880.0 78219.6 89207.0 92165.0 105547.5 107085.5 1176.9 1178.7 1223.5 1228.4 1230.2 19227.3 19562.4 19581.9 19693.9 19695.4 45642.5 45694.3 46289.3 46802.5 48034.5 63259.4 63314.1 63462.4 64594.0 65815.3 9020.0 9194.0 9228.2 9279.3 9368.4 10110.5 14258.2 14745.9 15051.7 15080.6 10826.8 12279.4 12368.6 12432.5 12773.6 11985.2 12183.7 12622.3 12648.6 12694.6 12382.3 12524.5 12740.3 12810.9 12832.3 9123.3 9290.8 9351.7 9431.9 9646.3 8860.8 11721.6 12108.5 12147.8 12245.1 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | [#3] mootools.html Cycles:180 Average:5635.58 Median:4995.82 stddev:3077.64 (61.6%) stddev-sans-first:3070.43 01:15:57 INFO - PROCESS | 17112 | Values: 1479.6 1492.4 1501.9 1502.3 1504.6 8149.2 8690.7 8693.8 8695.6 8695.9 7487.9 7739.9 8259.5 8429.4 8445.5 2363.4 2388.2 2402.2 2402.9 2406.9 2318.8 2359.8 2360.8 2368.1 2369.6 2380.4 2394.2 2400.5 2409.2 2437.2 2159.0 2182.2 2196.4 2199.8 2286.1 2298.1 2347.1 2350.6 2351.0 2352.4 8600.4 8654.1 8664.0 8676.9 8679.1 4907.1 5022.2 5084.5 5161.8 5163.2 3257.8 3335.1 3370.6 3397.2 3401.8 1322.3 1345.7 1390.6 1404.6 1404.7 11527.3 11568.5 11579.6 11580.8 11648.9 4456.0 4532.3 4542.4 4584.7 4645.3 9965.1 9971.9 9991.9 10000.1 10006.0 5308.1 5312.8 5313.5 5314.4 5316.0 4240.4 4358.2 4860.4 4866.0 4969.5 3920.1 3979.3 4035.3 4066.6 4101.7 1248.2 1255.1 1256.9 1260.7 1268.1 991.6 1008.5 1009.6 1014.1 1014.2 5700.3 5749.7 5816.0 5829.1 5850.4 1029.6 1031.0 1041.1 1043.9 1058.2 3971.9 4055.5 4097.6 4172.0 4190.4 9966.7 10219.8 10264.9 10285.8 10306.5 10078.0 10180.4 10200.0 10203.0 10213.1 8079.9 8122.6 8236.3 8236.5 8246.1 5870.7 5879.8 5930.9 5973.9 6033.6 9401.6 9403.9 9419.0 9439.2 9507.5 9281.8 9733.5 9758.2 9766.7 9775.7 6660.8 6789.1 6792.7 7275.9 7411.5 7716.9 8019.8 8226.3 8292.6 8316.3 7295.3 7630.6 7683.3 7812.0 7838.5 7634.8 7694.8 7758.8 7762.3 7904.1 6435.5 6546.4 6613.7 6614.2 6616.3 5170.3 5216.2 5231.7 5239.1 5266.6 5328.5 5333.0 5362.7 5420.3 5455.1 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | [#4] prototype.html Cycles:180 Average:4674.84 Median:5318.44 stddev:1305.94 (24.6%) stddev-sans-first:1269.42 01:15:57 INFO - PROCESS | 17112 | Values: 391.7 401.3 403.4 410.4 411.8 5300.6 5322.6 5334.8 5378.1 5385.8 5059.9 5155.3 5172.1 5175.2 5286.1 3742.9 4063.7 4131.9 4142.4 4164.7 4137.9 4138.9 4145.1 4171.8 4187.2 4161.7 4170.8 4179.2 4183.1 4186.7 4022.3 4172.3 4182.3 4190.1 4220.0 3851.1 3861.7 3862.2 3865.7 3900.3 5148.4 5196.5 5215.6 5220.9 5253.3 4833.9 4837.0 4955.0 4957.3 4964.0 5493.2 5510.9 5512.7 5551.9 5560.9 4264.0 4278.7 4279.7 4281.9 4310.8 5316.2 5494.5 5690.9 5706.5 5751.3 4313.8 4330.1 4333.5 4357.8 4366.4 4399.1 4400.1 4403.1 4409.3 4439.8 4772.8 4803.0 4883.1 4897.7 4899.0 5536.6 5540.0 5549.3 5555.2 5564.7 1454.7 1463.9 1478.3 1480.2 1484.2 1032.0 1081.2 1092.7 1099.2 1100.2 5320.7 5325.7 5346.8 5351.8 5384.7 5447.3 5463.9 5478.9 5483.9 5489.5 5164.5 5259.9 5291.8 5475.4 5526.7 2942.5 2944.2 2956.5 2957.6 2961.9 5598.0 5755.9 5784.2 5796.0 5802.3 5448.9 5470.4 5523.2 5534.3 5665.7 5604.4 5672.1 5677.1 5679.5 5696.6 5335.9 5440.8 5448.5 5479.9 5494.7 5391.9 5422.5 5423.8 5431.6 5439.6 5595.9 5680.5 5724.2 5832.4 5844.9 4113.0 4132.3 4144.7 4165.4 4175.7 5552.9 5624.0 5674.2 5691.8 5694.5 5417.0 5435.6 5454.9 5480.2 5485.2 5486.1 5498.0 5499.5 5509.2 5513.6 5347.1 5472.0 5488.9 5510.2 5547.0 5429.9 5502.8 5560.2 5561.9 5565.8 5292.9 5349.3 5351.5 5368.5 5372.9 01:15:57 INFO - PROCESS | 17112 | 01:15:57 INFO - PROCESS | 17112 | [#5] yui.html Cycles:180 Average:18127.32 Median:42037.90 stddev:22067.10 (52.5%) stddev-sans-first:22090.71 01:15:57 INFO - PROCESS | 17112 | Values: 816.4 838.5 845.9 930.0 943.7 16649.5 17441.1 18560.8 18604.7 18613.4 16184.5 16648.7 16803.1 16913.2 16957.3 816.2 830.6 832.7 833.0 833.7 702.1 708.4 832.8 834.0 834.3 845.0 852.6 870.7 874.2 874.8 852.3 852.6 853.7 855.9 858.7 542.5 544.0 615.0 615.4 615.4 16601.9 17042.7 17062.1 17074.3 17194.8 16540.7 16883.7 17052.7 17285.7 17550.1 13477.3 13499.4 13544.2 13738.9 13741.5 4004.5 4033.2 4089.3 4104.2 4121.1 79815.0 80710.0 81639.0 83232.0 83864.2 12440.3 12458.6 12693.6 12717.6 12844.2 25263.5 25324.0 25428.2 25734.9 25913.5 9195.2 9235.8 9364.4 9369.3 9386.7 4557.5 4579.3 4605.4 4700.9 4717.5 3841.6 3917.8 3960.8 3966.2 3998.5 608.1 610.2 617.3 618.1 627.0 694.6 697.8 708.6 714.4 715.6 10515.8 10622.9 11123.9 11136.6 11273.0 737.2 769.7 839.6 847.2 877.2 5382.1 5390.9 5502.3 5728.2 5733.7 71617.0 75517.0 75869.6 78241.0 78303.2 67161.7 67465.3 67775.3 68623.7 69002.3 60373.4 60401.4 60457.7 60513.7 60524.4 10770.9 10809.7 11046.4 11170.4 11189.9 41831.8 42244.0 42657.0 43252.8 43363.6 51235.5 53327.5 53769.2 53952.2 54018.7 12839.4 13238.3 13350.1 13404.1 13492.4 13579.5 13853.8 13867.7 13932.3 13974.0 13000.2 13213.0 13313.7 13564.3 13574.5 13983.1 14092.7 14113.9 14131.8 14226.5 13604.0 14491.0 14969.5 15042.3 15252.1 11947.2 12018.5 12211.3 12348.3 12765.6 11661.8 11797.8 11944.4 11977.9 13113.5 01:15:57 INFO - PROCESS | 17112 | -------- Summary: end -------- 01:15:57 INFO - PROCESS | 17112 | 01:15:58 INFO - TEST-INFO | 17112: exit 0 01:15:58 INFO - TEST-OK | dromaeo_css | took 1113750ms 01:15:58 INFO - TEST-START | kraken 01:15:58 INFO - operating with platform_type : linux_ 01:15:58 INFO - Initialising browser for kraken test... 01:15:58 INFO - TEST-INFO | started process 17431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxN0Eqv/profile http://localhost:43087/getInfo.html) 01:16:02 INFO - PROCESS | 17431 | __metrics Screen width/height:1600/1200 01:16:02 INFO - PROCESS | 17431 | colorDepth:24 01:16:02 INFO - PROCESS | 17431 | Browser inner width/height: 1024/697 01:16:02 INFO - PROCESS | 17431 | __metrics 01:16:03 INFO - PROCESS | 17431 | 1486458963161 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 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 01:16:03 INFO - PROCESS | 17431 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:16:03 INFO - PROCESS | 17431 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:16:03 INFO - PROCESS | 17431 | console.error: PushService: 01:16:03 INFO - PROCESS | 17431 | stateChangeProcessEnqueue: Error transitioning state 01:16:03 INFO - PROCESS | 17431 | UnknownError 01:16:04 INFO - TEST-INFO | 17431: exit 0 01:16:04 INFO - Browser initialized. 01:16:04 INFO - Running cycle 1/1 for kraken test... 01:16:04 INFO - TEST-INFO | started process 17523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxN0Eqv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:16 INFO - PROCESS | 17523 | RSS: Main: 138186752 01:16:16 INFO - PROCESS | 17523 | 01:16:18 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43087/tests/kraken/driver.html?testName=audio-beat-detection) 01:16:19 INFO - PROCESS | 17523 | RSS: Main: 182136832 01:16:19 INFO - PROCESS | 17523 | 01:16:22 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43087/tests/kraken/driver.html?testName=audio-dft) 01:16:22 INFO - PROCESS | 17523 | RSS: Main: 172269568 01:16:22 INFO - PROCESS | 17523 | 01:16:25 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43087/tests/kraken/driver.html?testName=audio-fft) 01:16:26 INFO - PROCESS | 17523 | RSS: Main: 264122368 01:16:26 INFO - PROCESS | 17523 | 01:16:28 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43087/tests/kraken/driver.html?testName=audio-oscillator) 01:16:28 INFO - PROCESS | 17523 | RSS: Main: 170299392 01:16:28 INFO - PROCESS | 17523 | 01:16:30 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43087/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:16:31 INFO - PROCESS | 17523 | RSS: Main: 173391872 01:16:31 INFO - PROCESS | 17523 | 01:16:34 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43087/tests/kraken/driver.html?testName=imaging-darkroom) 01:16:34 INFO - PROCESS | 17523 | RSS: Main: 211156992 01:16:34 INFO - PROCESS | 17523 | 01:16:38 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43087/tests/kraken/driver.html?testName=imaging-desaturate) 01:16:38 INFO - PROCESS | 17523 | RSS: Main: 210837504 01:16:38 INFO - PROCESS | 17523 | 01:16:41 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43087/tests/kraken/driver.html?testName=json-parse-financial) 01:16:42 INFO - PROCESS | 17523 | RSS: Main: 208388096 01:16:42 INFO - PROCESS | 17523 | 01:16:43 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43087/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:16:44 INFO - PROCESS | 17523 | RSS: Main: 170315776 01:16:44 INFO - PROCESS | 17523 | 01:16:46 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:16:46 INFO - PROCESS | 17523 | RSS: Main: 178237440 01:16:46 INFO - PROCESS | 17523 | 01:16:48 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:16:49 INFO - PROCESS | 17523 | RSS: Main: 187170816 01:16:49 INFO - PROCESS | 17523 | 01:16:51 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:16:52 INFO - PROCESS | 17523 | RSS: Main: 196816896 01:16:52 INFO - PROCESS | 17523 | 01:16:55 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:16:55 INFO - PROCESS | 17523 | RSS: Main: 192417792 01:16:55 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | Cycle 1(1): loaded http://localhost:43087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43087/tests/kraken/driver.html?testName=ai-astar) 01:16:57 INFO - PROCESS | 17523 | RSS: Main: 244584448 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | __start_tp_report 01:16:57 INFO - PROCESS | 17523 | _x_x_mozilla_page_load 01:16:57 INFO - PROCESS | 17523 | _x_x_mozilla_page_load_details 01:16:57 INFO - PROCESS | 17523 | |i|pagename|runs| 01:16:57 INFO - PROCESS | 17523 | |0;ai-astar;111;114;113;113;114;112;111;112;113;113 01:16:57 INFO - PROCESS | 17523 | |1;audio-beat-detection;149;117;118;153;118;119;117;116;137;123 01:16:57 INFO - PROCESS | 17523 | |2;audio-dft;162;158;160;160;160;160;160;162;160;161 01:16:57 INFO - PROCESS | 17523 | |3;audio-fft;75;76;75;111;75;77;76;76;100;76 01:16:57 INFO - PROCESS | 17523 | |4;audio-oscillator;82;82;112;83;82;82;93;83;83;106 01:16:57 INFO - PROCESS | 17523 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 01:16:57 INFO - PROCESS | 17523 | |6;imaging-darkroom;146;147;147;147;147;146;147;147;146;146 01:16:57 INFO - PROCESS | 17523 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;96 01:16:57 INFO - PROCESS | 17523 | |8;json-parse-financial;49;49;49;49;51;52;59;49;49;49 01:16:57 INFO - PROCESS | 17523 | |9;json-stringify-tinderbox;64;65;65;76;64;64;64;65;65;64 01:16:57 INFO - PROCESS | 17523 | |10;stanford-crypto-aes;79;80;77;76;76;77;81;86;76;82 01:16:57 INFO - PROCESS | 17523 | |11;stanford-crypto-ccm;127;122;120;127;121;123;120;126;162;123 01:16:57 INFO - PROCESS | 17523 | |12;stanford-crypto-pbkdf2;159;162;161;158;158;157;158;156;158;157 01:16:57 INFO - PROCESS | 17523 | |13;stanford-crypto-sha256-iterative;64;61;60;62;60;62;62;67;60;59 01:16:57 INFO - PROCESS | 17523 | __end_tp_report 01:16:57 INFO - PROCESS | 17523 | __start_cc_report 01:16:57 INFO - PROCESS | 17523 | _x_x_mozilla_cycle_collect,1542 01:16:57 INFO - PROCESS | 17523 | __end_cc_report 01:16:57 INFO - PROCESS | 17523 | __startTimestamp1486459017714__endTimestamp 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | ------- Summary: start ------- 01:16:57 INFO - PROCESS | 17523 | Number of tests: 14 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.07 (1.0%) stddev-sans-first:0.97 01:16:57 INFO - PROCESS | 17523 | Values: 111.0 114.0 113.0 113.0 114.0 112.0 111.0 112.0 113.0 113.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:121.00 stddev:14.23 (11.8%) stddev-sans-first:12.60 01:16:57 INFO - PROCESS | 17523 | Values: 149.0 117.0 118.0 153.0 118.0 119.0 117.0 116.0 137.0 123.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.16 (0.7%) stddev-sans-first:1.05 01:16:57 INFO - PROCESS | 17523 | Values: 162.0 158.0 160.0 160.0 160.0 160.0 160.0 162.0 160.0 161.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.82 (16.9%) stddev-sans-first:13.37 01:16:57 INFO - PROCESS | 17523 | Values: 75.0 76.0 75.0 111.0 75.0 77.0 76.0 76.0 100.0 76.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.50 stddev:11.24 (13.6%) stddev-sans-first:11.65 01:16:57 INFO - PROCESS | 17523 | Values: 82.0 82.0 112.0 83.0 82.0 82.0 93.0 83.0 83.0 106.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:16:57 INFO - PROCESS | 17523 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 01:16:57 INFO - PROCESS | 17523 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:16:57 INFO - PROCESS | 17523 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:49.00 stddev:3.17 (6.5%) stddev-sans-first:3.32 01:16:57 INFO - PROCESS | 17523 | Values: 49.0 49.0 49.0 49.0 51.0 52.0 59.0 49.0 49.0 49.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:3.69 (5.7%) stddev-sans-first:3.87 01:16:57 INFO - PROCESS | 17523 | Values: 64.0 65.0 65.0 76.0 64.0 64.0 64.0 65.0 65.0 64.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.50 stddev:3.30 (4.2%) stddev-sans-first:3.50 01:16:57 INFO - PROCESS | 17523 | Values: 79.0 80.0 77.0 76.0 76.0 77.0 81.0 86.0 76.0 82.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:124.50 stddev:12.55 (10.1%) stddev-sans-first:13.31 01:16:57 INFO - PROCESS | 17523 | Values: 127.0 122.0 120.0 127.0 121.0 123.0 120.0 126.0 162.0 123.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.00 stddev:1.84 (1.2%) stddev-sans-first:1.94 01:16:57 INFO - PROCESS | 17523 | Values: 159.0 162.0 161.0 158.0 158.0 157.0 158.0 156.0 158.0 157.0 01:16:57 INFO - PROCESS | 17523 | 01:16:57 INFO - PROCESS | 17523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:2.36 (3.8%) stddev-sans-first:2.35 01:16:57 INFO - PROCESS | 17523 | Values: 64.0 61.0 60.0 62.0 60.0 62.0 62.0 67.0 60.0 59.0 01:16:57 INFO - PROCESS | 17523 | -------- Summary: end -------- 01:16:57 INFO - PROCESS | 17523 | 01:16:58 INFO - TEST-INFO | 17523: exit 0 01:16:58 INFO - TEST-OK | kraken | took 60512ms 01:16:58 INFO - SUITE-END | took 1174s 01:16:58 INFO - Completed test suite (00:19:34) 01:16:58 INFO - javascript benchmark 01:16:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.7236884864787, 3252.869885204592, 3289.8190599517015, 3305.3224089061746, 3310.0, 5346.224797404374, 5399.028174928511, 5409.513143817051, 5423.186522021689, 5441.183822426638, 5442.755076021579, 5468.808591699291, 5480.725963701819, 5484.862878428041, 5490.615656904019, 4872.658913876021, 4885.584725298354, 4920.065187614359, 4949.406071271453, 4970.2296144097545, 4770.332153498513, 4904.754762261872, 4953.628477864157, 4960.7767650455635, 4988.850334489953, 4736.668433209659, 4740.07568524138, 4767.04659068186, 4770.4275486941615, 4844.636652251078, 4833.516648335173, 4865.3675022247235, 4871.561559459666, 4876.756162191894, 4892.266160075981, 4764.976175119103, 4812.326274321597, 4816.181249187646, 4842.055799119174, 4843.927341089887, 5184.662996905189, 5280.683159010472, 5316.521513063804, 5368.30212072432, 5369.275147855029, 5814.592978491507, 5816.9820281451, 5819.854503637401, 5822.359540450547, 5834.212381328509, 5848.064309710426, 5870.941290587082, 5871.383504731984, 5903.0, 5903.026000709878, 5235.58115350771, 5272.393674727378, 5287.656302340336, 5303.946960530346, 5463.672179669233, 5808.273965754281, 5808.564357673107, 5815.79644712433, 5832.650040997553, 5853.0, 5595.776168953196, 5602.915956260659, 5603.10350343943, 5604.943950560524, 5608.270924779753, 5588.105903055492, 5622.269105016322, 5625.0, 5664.376918538957, 5675.943240567624, 5685.289338832646, 5687.146927960839, 5699.629524080921, 5720.570957178145, 5729.742161602738, 5699.401562835926, 5746.396628354046, 5746.770129194785, 5751.884962300731, 5762.711864406763, 4224.408582798349, 4238.936415953764, 4407.162639098561, 4409.603135717801, 4445.5776701213335, 3936.9015774605864, 3967.563568007517, 3972.4239985201984, 3998.300297447935, 4014.197160567898, 5639.436056394327, 5645.350784659735, 5646.8023619173955, 5656.717164141776, 5667.3482549507335, 5584.776608935678, 5622.0, 5665.065264231438, 5843.328017277982, 5846.970765146232, 5531.9723401382735, 5586.497215250647, 5588.860278492989, 5620.353659329147, 5623.015972204929, 4942.950570494321, 4947.48051454592, 4950.232713929347, 4950.331705219749, 4980.178270585386, 5895.67573783446, 5922.289325280908, 5925.911111333334, 5963.0, 5984.521238300926, 5655.547556195576, 5689.317281926195, 5700.515456186271, 5754.6547207167705, 5788.681622510634, 5968.820935371946, 5983.162357269899, 5987.251593550806, 5994.100884867305, 5997.460228579449, 5657.264555607745, 5657.85855353603, 5662.065759149859, 5662.348829884616, 5664.0, 5606.971965140148, 5630.042892708331, 5642.943570564242, 5691.373948865705, 5694.544436444991, 5564.1931919870585, 5604.0, 5608.242887210175, 5617.9719101404235, 5638.689872057076, 5607.186957891001, 5611.298587676541, 5612.298462692163, 5613.129964855454, 5615.298087739033, 5376.677399356051, 5392.325959255093, 5515.972420137874, 5551.916721249104, 5597.80407685729, 5649.096144616841, 5656.547476201812, 5656.660600363992, 5684.488396044376, 5688.40271771458, 5524.254225679482, 5526.392096869261, 5532.861678458071, 5533.861653458695, 5534.39121696605], "value": 5306.544699965968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.7022278890047, 582.6300299309938, 612.3172662481331, 636.4208570201118, 646.3019938466457, 37034.62965370346, 47442.0, 49055.50944490554, 49081.263781043315, 49166.0, 51824.0, 52125.0, 52393.47606523934, 52473.73763131189, 52527.47472525274, 8949.239314658262, 9469.85795213074, 9638.277129215337, 9659.951700241489, 9667.984861589537, 8935.55322233889, 10365.326253793517, 10560.207984401162, 10578.047975682188, 10956.12351011917, 10466.581336746522, 10495.79008419835, 10511.316764410327, 10514.211434142431, 10518.579256829718, 11798.764024719501, 11818.822717659243, 11878.762424751543, 11899.940500297529, 11899.940500297529, 11782.175247732663, 11857.169998100137, 11868.169228154033, 11870.465829037714, 11879.168458207929, 48947.755261223465, 49113.754431227615, 49271.0, 49318.50681493211, 49380.50619493831, 4542.500324964251, 4551.317302404633, 4636.907261854778, 4709.789041737924, 4724.5984091352275, 35098.824505877565, 35845.64154358449, 36007.81996090029, 36470.63529364699, 37874.0, 4673.649476289258, 4709.364235828154, 4731.7634118293945, 4743.501932297094, 4772.141014617368, 360781.9999999974, 361330.0, 361411.0, 362956.0, 363349.0, 71708.64145679238, 71909.0, 72321.63839180875, 72367.27632723711, 72415.27584724191, 76873.0, 77377.61311193409, 77379.0, 77599.61200194075, 77709.6114519435, 19767.209311627663, 20280.797192028185, 20309.492262693257, 20315.796842031687, 20324.288649897182, 14315.28423578817, 14542.127472351693, 15394.461193858162, 15747.527574172793, 15850.44523441674, 19607.411777646408, 20516.0, 20650.17399304011, 20688.58622827565, 20743.066562004748, 6268.153799237136, 6288.182536270256, 6320.6094659174905, 6457.0, 6539.692061587702, 980.7204946590188, 989.3371441134457, 997.33677104726, 1000.9399436033862, 1013.0325539110132, 35150.29699405997, 35274.34111025721, 35473.46789798155, 35725.64274357223, 35853.35470711154, 1092.6667366453307, 1140.931544107356, 1145.8624965004087, 1164.2897832322276, 1191.7497325561555, 18309.633807324044, 18563.90718046401, 18644.906775466035, 19045.142968566448, 19050.61898762017, 495923.0, 499674.0, 501601.0, 502147.0, 502214.0, 72762.27237727556, 72920.0, 73037.26962730305, 73117.6344118276, 73206.0, 1472.3668822406469, 1531.5788158256569, 1534.9923250383677, 1539.4227164813194, 1545.63677535779, 32646.51030234501, 34193.31613367768, 34589.65410345864, 34607.30785384329, 34805.303893922486, 60859.39140608537, 61455.38544614497, 61466.0, 61559.0, 61569.0, 374626.0, 374789.0, 374895.0, 375847.0, 376596.0, 40998.95005249785, 41071.38392924049, 45114.77442612766, 45798.0, 46692.7665361671, 49976.500234997184, 50565.49434505755, 50874.0, 51146.0, 51159.69781359773, 41334.586654133076, 41615.7919210402, 41755.0, 41945.37081943834, 43603.345949810144, 42311.7884410576, 42597.36103958505, 42933.785331073144, 43471.0, 43730.78134609306, 41740.582594174884, 41783.582164179184, 41945.37081943712, 42425.78787106045, 42489.36265955951, 35420.82289588536, 37180.44229336616, 37281.254374911805, 37498.43752343662, 38130.61869381271, 27633.86183069072, 27824.0, 27970.160895173176, 28034.579481308203, 28072.71927280701], "value": 22377.05434649147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.4271627498265, 407.3197759741233, 407.50479780164494, 422.73367778299666, 435.4143676754764, 19878.40364789057, 20796.16815327385, 21972.8901355493, 22067.668984965218, 22299.21952731655, 22329.10683572655, 24286.87856560715, 24678.0, 24796.380090497747, 26057.73942260577, 6704.832379190522, 6902.689378977958, 7000.859982800341, 7002.929970700304, 7140.393066589346, 6964.338387853171, 6991.755288564901, 7033.8593228135405, 7033.894491582605, 7042.82392940178, 6859.142607174103, 6943.51395402322, 6964.512484126113, 7026.578405295673, 7030.894536581955, 6837.487188460886, 7006.859862802716, 7031.929680703204, 7082.185548661892, 7083.043789088459, 6811.829704257384, 6834.2482326944, 6842.931570684279, 6847.1783385994, 6847.93152068478, 29746.174113459187, 29955.850220748758, 30600.0, 30669.539956900666, 30915.22711932197, 3543.114221444639, 3564.4296912494137, 3583.068402215417, 3658.3414985302634, 3680.0615842959874, 14171.716565668628, 17040.573985650335, 17491.650166996715, 17668.381606643707, 18727.812721872742, 2143.4427048967223, 2160.2007257314735, 2221.8444708870384, 2235.9776402235934, 2271.2958982715245, 85918.57040714819, 94015.05984940131, 103458.99999999924, 117457.0, 119067.0, 20415.285465008652, 20435.693464598044, 20719.792802072086, 20990.580188396147, 21367.78632213689, 40270.0, 40316.0, 40377.596224037385, 40716.38925416121, 41049.38425923613, 8916.777080573038, 9142.3600347975, 9335.113164249386, 9579.425234485952, 11771.058315334752, 9374.718758437259, 9379.859302110473, 9401.57692903821, 9413.435193888252, 9606.991265917119, 5199.896002079937, 5202.3497062867145, 5221.660592061504, 5231.110711179109, 5246.3704355477585, 2051.5178932950744, 2086.5201003768916, 2106.789321067881, 2120.1731324783345, 2153.1817909194406, 924.58393722825, 937.3110763588757, 943.1841457139525, 946.4037656276502, 948.6774496671165, 19103.904480477788, 20754.377368678965, 22289.88855055747, 22956.770432295463, 23299.7670023301, 1046.2571574182416, 1067.594314160614, 1070.662741236508, 1081.0648788797791, 1085.4572713643179, 11456.59901903446, 11591.6522504325, 11667.59163429276, 11731.47208375625, 11793.88206117945, 311975.0, 312700.0, 313257.0, 645207.0, 676880.0, 78219.60890195513, 89207.0, 92165.0, 105547.4722626382, 107085.46457267819, 1176.9470373833199, 1178.6798785360452, 1223.5289413575838, 1228.416502161466, 1230.1573422205818, 19227.327043553407, 19562.413127606196, 19581.902090489457, 19693.901530492254, 19695.409137725892, 45642.543574565156, 45694.314585281914, 46289.3056604158, 46802.53197467982, 48034.519654804404, 63259.36740632719, 63314.05028924662, 63462.365376345646, 64594.0, 65815.34184658092, 9020.0, 9194.0, 9228.169464747936, 9279.257659387098, 9368.4378937264, 10110.545025473724, 14258.215798131203, 14745.852541474447, 15051.698966020836, 15080.622984425478, 10826.837597436202, 12279.44742486608, 12368.628941131781, 12432.502699892264, 12773.55292564793, 11985.22096063753, 12183.695407614881, 12622.305773182563, 12648.557300494807, 12694.555690550786, 12382.318972456602, 12524.49902003946, 12740.299283539494, 12810.935945320587, 12832.294223817406, 9123.315751318545, 9290.814183716422, 9351.672691455766, 9431.858522122311, 9646.324757267204, 8860.822783544421, 11721.648350549498, 12108.455119519818, 12147.817782733442, 12245.081618878441], "value": 10942.950716881742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.5561331600518, 1492.395579790185, 1501.932413041413, 1502.2563830903705, 1504.6464080940978, 8149.225823546761, 8690.652373905044, 8693.782655433617, 8695.565221738903, 8695.869561956575, 7487.9251207487905, 7739.883901741464, 8259.545724985124, 8429.409941304097, 8445.451045682026, 2363.3500787283506, 2388.176079252655, 2402.2072716003677, 2402.903883844644, 2406.867622280774, 2318.7565305642916, 2359.7758212969825, 2360.7639236076343, 2368.100121953655, 2369.609014512603, 2380.4048987753063, 2394.1740099665676, 2400.459896523286, 2409.156795121702, 2437.1835435129165, 2159.028437203257, 2182.1707751054655, 2196.3959911024435, 2199.7690242524623, 2286.0627142871426, 2298.1496846166856, 2347.061175529802, 2350.576896158691, 2350.9882450587806, 2352.447174913911, 8600.397972141953, 8654.134586541295, 8663.95668021656, 8676.913230867736, 8679.088695686989, 4907.141250281186, 5022.196448568212, 5084.51697088776, 5161.845144645667, 5163.199704045879, 3257.755668324885, 3335.0661814691925, 3370.6292307846115, 3397.2016576104597, 3401.7958922464486, 1322.3322222277784, 1345.7039451320693, 1390.5967269491834, 1404.557564367221, 1404.712034033031, 11527.308361498337, 11568.479418426106, 11579.594714184963, 11580.76838463226, 11648.883511164864, 4455.952851079994, 4532.297493888453, 4542.386777785023, 4584.701994370355, 4645.349651048856, 9965.053319934595, 9971.900280997097, 9991.850122248172, 10000.099991000845, 10006.0, 5308.0710875596615, 5312.787488500417, 5313.468653134733, 5314.415414304423, 5316.016536940679, 4240.38514415408, 4358.193734159191, 4860.416749989953, 4866.0, 4969.453360130383, 3920.137569734654, 3979.3434083376496, 4035.2534781065597, 4066.552679205285, 4101.671866250693, 1248.1574936917543, 1255.1402289431585, 1256.8994480441543, 1260.684828792802, 1268.1123213750411, 991.5984026469291, 1008.5058321422597, 1009.6264382178641, 1014.1278500489573, 1014.1937159957852, 5700.258966334433, 5749.741261643236, 5815.9709201453725, 5829.125631155361, 5850.444207800252, 1029.6396261308632, 1031.0, 1041.1358572384902, 1043.8517630606273, 1058.2063452410691, 3971.8808435746973, 4055.4525139105845, 4097.610726980932, 4171.958280417218, 4190.371444283321, 9966.651167209113, 10219.795604088025, 10264.948675256725, 10285.845712314322, 10306.536205870754, 10078.032796681466, 10180.440075795903, 10200.0, 10203.03071208234, 10213.08082272599, 8079.9192008080345, 8122.553259570662, 8236.258736713604, 8236.464629799044, 8246.09292977784, 5870.706464676664, 5879.764809407576, 5930.881382372242, 5973.940260597338, 6033.637981720935, 9401.623935042522, 9403.85894211601, 9418.95290523543, 9439.244860411289, 9507.477088760184, 9281.767955801159, 9733.464659443798, 9758.170555502862, 9766.706998789763, 9775.706728798148, 6660.83347916306, 6789.083473730983, 6792.66036698173, 7275.854482910207, 7411.481196316422, 7716.884246736416, 8019.799505012421, 8226.341892648694, 8292.58537073156, 8316.334693224406, 7295.343419092307, 7630.618469076413, 7683.270089341504, 7811.960940195263, 7838.490498117832, 7634.8091297718, 7694.846103078019, 7758.7672369829, 7762.340201082745, 7904.13054563986, 6435.51733619971, 6546.410823025951, 6613.702383392855, 6614.206295244409, 6616.305287944697, 5170.302009228856, 5216.217567364925, 5231.692076980755, 5239.109351410193, 5266.578673706171, 5328.467153284795, 5333.040052790535, 5362.65142765719, 5420.268263784496, 5455.1271796512365], "value": 4593.4244183451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.66903966148595, 401.2817057467134, 403.3707416430368, 410.44179915315186, 411.8249743858863, 5300.602454815889, 5322.6427261048475, 5334.759935802888, 5378.139497680372, 5385.81149659762, 5059.949400505994, 5155.329807125077, 5172.09488339541, 5175.170373923298, 5286.074936886049, 3742.8502859885707, 4063.6952228582827, 4131.855385061531, 4142.357934520154, 4164.666826653875, 4137.8758637240935, 4138.882501724547, 4145.0880806222585, 4171.791410429481, 4187.183499217654, 4161.708680392374, 4170.812313445887, 4179.164167166578, 4183.142455796569, 4186.665066794664, 4022.275990321741, 4172.269852775752, 4182.2890108681595, 4190.078182799794, 4220.0, 3851.094992676719, 3861.7296789224765, 3862.246861861938, 3865.7100717446306, 3900.317444447239, 5148.433672296044, 5196.53231209193, 5215.6349055566125, 5220.8694782630355, 5253.317068781034, 4833.903321933577, 4837.0, 4955.0, 4957.256411538262, 4963.975180124113, 5493.2034854946205, 5510.91733623996, 5512.724363781795, 5551.8889622207735, 5560.888782224333, 4263.976645605064, 4278.743275403485, 4279.679024073207, 4281.871543853689, 4310.762908040057, 5316.20256961455, 5494.478024587658, 5690.886182276331, 5706.457886500776, 5751.281089863767, 4313.805878735465, 4330.112326972963, 4333.544977777288, 4357.782110894443, 4366.4238099521435, 4399.12017596482, 4400.141972315368, 4403.141387429485, 4409.316555933835, 4439.8002089905385, 4772.809087636525, 4802.975985120122, 4883.121038213085, 4897.657163998486, 4898.975505122523, 5536.640118392292, 5539.972300138474, 5549.250851135045, 5555.194496797942, 5564.666120032811, 1454.701786133861, 1463.9386444827628, 1478.2608695652175, 1480.2302802542617, 1484.1762821634097, 1031.9577227000784, 1081.1512962324537, 1092.6558134187705, 1099.2415233488866, 1100.1638754546443, 5320.680759154463, 5325.707086110224, 5346.839594812084, 5351.812686555952, 5384.6769193848495, 5447.319085114361, 5463.9180412293845, 5478.890422191534, 5483.862903427446, 5489.533389661844, 5164.535191832753, 5259.868503287372, 5291.841244762663, 5475.425080366584, 5526.723663816793, 2942.4997750382486, 2944.2050646325374, 2956.4678357895787, 2957.5563665450354, 2961.8667159977854, 5598.040685759952, 5755.85610359736, 5784.219130417424, 5795.971020144872, 5802.274715660543, 5448.891022179534, 5470.425605311465, 5523.226748255248, 5534.335879694382, 5665.677072400378, 5604.41153678866, 5672.12082127271, 5677.091665333527, 5679.460451257124, 5696.629719068247, 5335.91705455773, 5440.82367053166, 5448.536874365724, 5479.917801233064, 5494.697791621339, 5391.9460805391445, 5422.457754224546, 5423.755930983037, 5431.5926305526455, 5439.5920305978, 5595.944040559542, 5680.488756011979, 5724.169995350734, 5832.358440571618, 5844.883102337844, 4113.01287690958, 4132.297509423465, 4144.70987030905, 4165.437665915063, 4175.665946724315, 5552.916706249329, 5624.015797235549, 5674.240985294572, 5691.800786972436, 5694.487496125369, 5416.9729151353995, 5435.592330575144, 5454.91817622728, 5480.177973304037, 5485.177223416519, 5486.067368547437, 5497.972510137423, 5499.532539734168, 5509.237044145835, 5513.61404701667, 5347.144456886879, 5471.972640136773, 5488.890222195454, 5510.201020852034, 5547.0, 5429.918551221655, 5502.844402675323, 5560.221568980265, 5561.888762224652, 5565.833025009256, 5292.911846017114, 5349.331333583302, 5351.538292385546, 5368.489993450616, 5372.919406208832], "value": 4284.426689675724, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.4325793573465, 838.4675730910877, 845.868890322, 929.9674511392103, 943.6932996776047, 16649.500514984557, 17441.12794360283, 18560.814391856093, 18604.720929186074, 18613.44159675212, 16184.514464566053, 16648.66702665946, 16803.0758308293, 16913.154342282898, 16957.32170713173, 816.1797393619419, 830.5847076461769, 832.6960659359321, 833.0253603284142, 833.6707000734706, 702.0767690487019, 708.4014008163094, 832.7501749475133, 834.0033659776569, 834.2741814621257, 845.0450990380891, 852.6205838401913, 870.7039606533777, 874.2394117118116, 874.8119154381807, 852.2840813716446, 852.5864955496579, 853.6798700487317, 855.8972923249219, 858.7295002074327, 542.4900593442152, 544.042485226005, 614.9508039356841, 615.3508049008294, 615.4491729901713, 16601.91699041509, 17042.74435883463, 17062.14689265544, 17074.31702731889, 17194.828051719447, 16540.6691866162, 16883.746743798853, 17052.658946821117, 17285.740713889303, 17550.122493875384, 13477.326133693276, 13499.392527336195, 13544.187348759007, 13738.931305343509, 13741.450341986309, 4004.5194576650697, 4033.1530378620523, 4089.3457046872654, 4104.240715467648, 4121.093359460914, 79815.0, 80710.0, 81639.0, 83231.99999999939, 83864.16135838625, 12440.319618839681, 12458.563950261878, 12693.555725549562, 12717.55488557896, 12844.229346239255, 25263.494730105296, 25324.0, 25428.237152885442, 25734.871325643253, 25913.481730365664, 9195.172434480928, 9235.815283694423, 9364.391314564531, 9369.344145909858, 9386.67146649864, 4557.544245575482, 4579.274220749569, 4605.40129783126, 4700.929486057712, 4717.504662010508, 3841.558220804643, 3917.7845218512684, 3960.801959902051, 3966.1671049080014, 3998.480197574355, 608.1121562518772, 610.2128254551667, 617.2685367839125, 618.1099217127322, 626.9655168965751, 694.6040756768695, 697.7767114523303, 708.624429052603, 714.4070421550101, 715.6099925540593, 10515.84226236607, 10622.94688526568, 11123.944380278046, 11136.610218642309, 11273.0, 737.178046478173, 769.6536558548676, 839.5927974932154, 847.1951645936385, 877.2280393253895, 5382.138857782736, 5390.892182156414, 5502.257195278667, 5728.198052272685, 5733.684647344436, 71617.0, 75517.0, 75869.62065189639, 78241.0, 78303.21696782959, 67161.66419167873, 67465.3253467459, 67775.32224677788, 68623.65688171628, 69002.30997689959, 60373.39626603766, 60401.39598604046, 60457.69771151116, 60513.69743151256, 60524.39475605276, 10770.892291076989, 10809.729756756144, 11046.392448415414, 11170.441477926233, 11189.944050279697, 41831.7908410456, 42244.0, 42657.0, 43252.78373608112, 43363.56636433722, 51235.487645124565, 53327.46672533225, 53769.19346209732, 53952.19071714006, 54018.729906350214, 12839.422225999666, 13238.273026969227, 13350.132241404277, 13404.128731632412, 13492.392842321922, 13579.456821727415, 13853.792193117313, 13867.653308667364, 13932.30338483092, 13974.0, 13000.219986800823, 13213.0, 13313.66715832112, 13564.253966031569, 13574.467663073014, 13983.091099078527, 14092.718145636825, 14113.929430352782, 14131.788023179455, 14226.502072427415, 13604.0, 14491.044298736877, 14969.476068337555, 15042.32309546095, 15252.084874907541, 11947.223430476992, 12018.459169337226, 12211.328376939353, 12348.259104453762, 12765.553205637758, 11661.76676466483, 11797.823032654345, 11944.402779860799, 11977.880221198026, 13113.508433397625], "value": 7658.458846421894, "unit": "score"}], "name": "dromaeo_css", "value": 7620.706667953806, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 114.0, 112.0, 111.0, 112.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 118.0, 153.0, 118.0, 119.0, 117.0, 116.0, 137.0, 123.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 111.0, 75.0, 77.0, 76.0, 76.0, 100.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 83.0, 82.0, 82.0, 93.0, 83.0, 83.0, 106.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 49.0, 51.0, 52.0, 59.0, 49.0, 49.0, 49.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 76.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 77.0, 76.0, 76.0, 77.0, 81.0, 86.0, 76.0, 82.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 120.0, 127.0, 121.0, 123.0, 120.0, 126.0, 162.0, 123.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 161.0, 158.0, 158.0, 157.0, 158.0, 156.0, 158.0, 157.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 60.0, 62.0, 60.0, 62.0, 62.0, 67.0, 60.0, 59.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1471.8, "alertThreshold": 2.0}]} 01:16:58 INFO - Return code: 0 01:16:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:16:59 ERROR - # TBPL SUCCESS # 01:16:59 INFO - Running post-action listener: _resource_record_post_action 01:16:59 INFO - [mozharness: 2017-02-07 09:16:59.008027Z] Finished run-tests step (success) 01:16:59 INFO - Running post-run listener: _resource_record_post_run 01:16:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 363065344; Read time: 32; Write time: 416944 01:16:59 INFO - TinderboxPrint: CPU usage
13.0% 01:16:59 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 01:16:59 INFO - TinderboxPrint: I/O write bytes / time
363,065,344 / 416,944 01:16:59 INFO - TinderboxPrint: CPU idle
8,266.5 (86.9%) 01:16:59 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 01:16:59 INFO - TinderboxPrint: Swap in / out
0 / 0 01:16:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110030848; Read time: 0; Write time: 155980 01:16:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253034496; Read time: 32; Write time: 260964 01:16:59 INFO - Running post-run listener: _upload_blobber_files 01:16:59 INFO - Blob upload gear active. 01:16:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:16:59 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:59 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:59 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:17:00 INFO - (blobuploader) - INFO - Open directory for files ... 01:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:00 INFO - (blobuploader) - INFO - Done attempting. 01:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:01 INFO - (blobuploader) - INFO - Done attempting. 01:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:05 INFO - (blobuploader) - INFO - Done attempting. 01:17:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:17:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:06 INFO - (blobuploader) - INFO - Done attempting. 01:17:06 INFO - (blobuploader) - INFO - Iteration through files over. 01:17:06 INFO - Return code: 0 01:17:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:17:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:17:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ad881a194b69601649b8a66bcbffbd20dbcc9f6137efbfce006c048b9ddce7c40c5788e092ebaf618f763da8b5bdb282972f2fd4ad823fdfe5eec3eb9e1e060a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cc55a2c71673bbe606c2e4d3db3d583e6c4573fc86bbb32d532306254b758e9723fdbbaa9a42338300bd59a59f750e4187081e896689433af98506bab8acbe82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/90d690c341e1891c9c8e2f11b41e647a5ec1df6cb2eef3acff61bda3e9390b1c62ba410c0a946c33295d0679ab6c77bd6fe42e2d694f094a02deb0f2127b5563", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a7b76181227b44911a450edf70c97c2273b5513608174ad1ab4ddc694c589ea95cf1acd8ef4ca3332065598e3562225a54a82ad6d10652f73bdb4d8ebe2ca9d0"} 01:17:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:17:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:17:06 INFO - Contents: 01:17:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ad881a194b69601649b8a66bcbffbd20dbcc9f6137efbfce006c048b9ddce7c40c5788e092ebaf618f763da8b5bdb282972f2fd4ad823fdfe5eec3eb9e1e060a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cc55a2c71673bbe606c2e4d3db3d583e6c4573fc86bbb32d532306254b758e9723fdbbaa9a42338300bd59a59f750e4187081e896689433af98506bab8acbe82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/90d690c341e1891c9c8e2f11b41e647a5ec1df6cb2eef3acff61bda3e9390b1c62ba410c0a946c33295d0679ab6c77bd6fe42e2d694f094a02deb0f2127b5563", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a7b76181227b44911a450edf70c97c2273b5513608174ad1ab4ddc694c589ea95cf1acd8ef4ca3332065598e3562225a54a82ad6d10652f73bdb4d8ebe2ca9d0"} 01:17:06 INFO - Running post-run listener: copy_logs_to_upload_dir 01:17:06 INFO - Copying logs to upload dir... 01:17:06 INFO - mkdir: /builds/slave/test/build/upload/logs 01:17:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.991430 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-07 01:17:06.863551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 01:17:06.867036) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ad881a194b69601649b8a66bcbffbd20dbcc9f6137efbfce006c048b9ddce7c40c5788e092ebaf618f763da8b5bdb282972f2fd4ad823fdfe5eec3eb9e1e060a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cc55a2c71673bbe606c2e4d3db3d583e6c4573fc86bbb32d532306254b758e9723fdbbaa9a42338300bd59a59f750e4187081e896689433af98506bab8acbe82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/90d690c341e1891c9c8e2f11b41e647a5ec1df6cb2eef3acff61bda3e9390b1c62ba410c0a946c33295d0679ab6c77bd6fe42e2d694f094a02deb0f2127b5563", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a7b76181227b44911a450edf70c97c2273b5513608174ad1ab4ddc694c589ea95cf1acd8ef4ca3332065598e3562225a54a82ad6d10652f73bdb4d8ebe2ca9d0"} build_url:https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/UKCxlCurS26kUJ6Jv-tR9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ad881a194b69601649b8a66bcbffbd20dbcc9f6137efbfce006c048b9ddce7c40c5788e092ebaf618f763da8b5bdb282972f2fd4ad823fdfe5eec3eb9e1e060a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cc55a2c71673bbe606c2e4d3db3d583e6c4573fc86bbb32d532306254b758e9723fdbbaa9a42338300bd59a59f750e4187081e896689433af98506bab8acbe82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/90d690c341e1891c9c8e2f11b41e647a5ec1df6cb2eef3acff61bda3e9390b1c62ba410c0a946c33295d0679ab6c77bd6fe42e2d694f094a02deb0f2127b5563", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a7b76181227b44911a450edf70c97c2273b5513608174ad1ab4ddc694c589ea95cf1acd8ef4ca3332065598e3562225a54a82ad6d10652f73bdb4d8ebe2ca9d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 01:17:06.891790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:17:06.892119) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486457787.20-1675653334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:17:06.974501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 01:17:06.974822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 01:17:06.975128) ========= ========= Total master_lag: 0.16 =========