builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1483956095.37 results: success (0) revision: 97896f92f196462e0072f8304b97c29217da1327 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.365906) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.366341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.366613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.381192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.381528) ========= 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=00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 02:01:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-01-09 02:01:35 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.385477 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.780537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.780857) ========= 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=00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.830894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:35.834298) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97896f92f196462e0072f8304b97c29217da1327 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 97896f92f196462e0072f8304b97c29217da1327 --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=00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 02:01:35,931 truncating revision to first 12 chars 2017-01-09 02:01:35,931 Setting DEBUG logging. 2017-01-09 02:01:35,931 attempt 1/10 2017-01-09 02:01:35,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97896f92f196?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 02:01:36,561 unpacking tar archive at: mozilla-central-97896f92f196/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948280 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:36.796221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:36.796550) ========= script_repo_revision: 97896f92f196462e0072f8304b97c29217da1327 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:36.797455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:36.797737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:36.807173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-01-09 02:01:36.807543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:01:36 INFO - MultiFileLogger online at 20170109 02:01:36 in /builds/slave/test 02:01:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:37 INFO - {'append_to_log': False, 02:01:37 INFO - 'base_work_dir': '/builds/slave/test', 02:01:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:01:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:37 INFO - 'branch': 'Firefox-Non-PGO', 02:01:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:37 INFO - 'config_files': ('talos/linux_config.py',), 02:01:37 INFO - 'default_actions': ('clobber', 02:01:37 INFO - 'read-buildbot-config', 02:01:37 INFO - 'download-and-extract', 02:01:37 INFO - 'populate-webroot', 02:01:37 INFO - 'create-virtualenv', 02:01:37 INFO - 'install', 02:01:37 INFO - 'run-tests'), 02:01:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:37 INFO - 'download_minidump_stackwalk': True, 02:01:37 INFO - 'download_symbols': 'ondemand', 02:01:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:37 INFO - 'installer_path': 'installer.exe', 02:01:37 INFO - 'log_level': 'info', 02:01:37 INFO - 'log_name': 'talos', 02:01:37 INFO - 'log_to_console': True, 02:01:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:01:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:01:37 INFO - 'opt_config_files': (), 02:01:37 INFO - 'pip_index': False, 02:01:37 INFO - 'sps_profile': False, 02:01:37 INFO - 'sps_profile_interval': 0, 02:01:37 INFO - 'suite': 'dromaeojs', 02:01:37 INFO - 'system_bits': '32', 02:01:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:37 INFO - 'title': 'talos-linux64-ix-016', 02:01:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:37 INFO - 'use_talos_json': True, 02:01:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:37 INFO - 'work_dir': 'build'} 02:01:37 INFO - [mozharness: 2017-01-09 10:01:37.005181Z] Running clobber step. 02:01:37 INFO - Running pre-action listener: _resource_record_pre_action 02:01:37 INFO - Running main action method: clobber 02:01:37 INFO - rmtree: /builds/slave/test/build 02:01:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:37 INFO - Running post-action listener: _resource_record_post_action 02:01:37 INFO - [mozharness: 2017-01-09 10:01:37.970142Z] Finished clobber step (success) 02:01:37 INFO - [mozharness: 2017-01-09 10:01:37.970250Z] Running read-buildbot-config step. 02:01:37 INFO - Running pre-action listener: _resource_record_pre_action 02:01:37 INFO - Running main action method: read_buildbot_config 02:01:37 INFO - Using buildbot properties: 02:01:37 INFO - { 02:01:37 INFO - "project": "", 02:01:37 INFO - "product": "firefox", 02:01:37 INFO - "who": "cbook@mozilla.com", 02:01:37 INFO - "installer_path": "public/build/target.tar.bz2", 02:01:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:01:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:01:37 INFO - "stage_platform": "linux64", 02:01:37 INFO - "basedir": "/builds/slave/test", 02:01:37 INFO - "buildnumber": 376, 02:01:37 INFO - "platform": "ubuntu64_hw", 02:01:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:01:37 INFO - "slavebuilddir": "test", 02:01:37 INFO - "taskId": "KgEM2vl_SAyoMEpvQcQKXA", 02:01:37 INFO - "branch": "mozilla-central", 02:01:37 INFO - "script_repo_revision": "production", 02:01:37 INFO - "revision": "97896f92f196462e0072f8304b97c29217da1327", 02:01:37 INFO - "slavename": "talos-linux64-ix-016", 02:01:37 INFO - "repo_path": "mozilla-central" 02:01:37 INFO - } 02:01:37 INFO - Finding installer, test and symbols from parent task. 02:01:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KgEM2vl_SAyoMEpvQcQKXA'}, attempt #1 02:01:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KgEM2vl_SAyoMEpvQcQKXA'}, attempt #1 02:01:39 INFO - Task dependencies: TKRNz3LhRaiB-kHVwgBa7A 02:01:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A'}, attempt #1 02:01:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2 02:01:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/test_packages.json 02:01:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.crashreporter-symbols.zip 02:01:39 INFO - Running post-action listener: _resource_record_post_action 02:01:39 INFO - [mozharness: 2017-01-09 10:01:39.818132Z] Finished read-buildbot-config step (success) 02:01:39 INFO - [mozharness: 2017-01-09 10:01:39.818348Z] Running download-and-extract step. 02:01:39 INFO - Running pre-action listener: _resource_record_pre_action 02:01:39 INFO - Running main action method: download_and_extract 02:01:39 INFO - mkdir: /builds/slave/test/build/tests 02:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:39 INFO - trying https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.test_packages.json 02:01:39 INFO - Downloading https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:01:40 INFO - Downloaded 896 bytes. 02:01:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:01:40 INFO - Using the following test package requirements: 02:01:40 INFO - {u'common': [u'target.common.tests.zip'], 02:01:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:01:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:01:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:01:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:01:40 INFO - u'mozbase': [u'target.common.tests.zip'], 02:01:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:01:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:01:40 INFO - u'web-platform': [u'target.common.tests.zip', 02:01:40 INFO - u'target.web-platform.tests.zip'], 02:01:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:01:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:01:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.common.tests.zip 02:01:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:01:40 INFO - Fetch https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.common.tests.zip into memory 02:01:49 INFO - Expected file size: 20251352 02:01:49 INFO - Obtained file size: 20251352 02:01:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:01:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.common.tests.zip 02:01:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:01:53 INFO - Fetch https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.common.tests.zip into memory 02:01:54 INFO - Expected file size: 20251352 02:01:54 INFO - Obtained file size: 20251352 02:01:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.talos.tests.zip 02:01:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:01:59 INFO - Fetch https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.talos.tests.zip into memory 02:02:06 INFO - Expected file size: 14403537 02:02:06 INFO - Obtained file size: 14403537 02:02: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')]} 02:02:07 INFO - trying https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2 02:02:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:02:08 INFO - Downloaded 55815949 bytes. 02:02:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2 02:02:08 INFO - mkdir: /builds/slave/test/properties 02:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:08 INFO - Contents: 02:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2 02:02:08 INFO - Running post-action listener: _resource_record_post_action 02:02:08 INFO - Running post-action listener: set_extra_try_arguments 02:02:08 INFO - [mozharness: 2017-01-09 10:02:08.777043Z] Finished download-and-extract step (success) 02:02:08 INFO - [mozharness: 2017-01-09 10:02:08.777140Z] Running populate-webroot step. 02:02:08 INFO - Running pre-action listener: _resource_record_pre_action 02:02:08 INFO - Running main action method: populate_webroot 02:02:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:08 INFO - '--tppagecycles', 02:02:08 INFO - '7'], 02:02:08 INFO - 'tests': ['tsvgm']}}, 02:02:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:02:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:02:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:02:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:02:08 INFO - 'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:02:08 INFO - 'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['damp', 'tps']}, 02:02:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:02:08 INFO - 'tests': ['damp', 'tps']}, 02:02:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['dromaeo_dom']}, 02:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['basic_compositor_video']}, 02:02:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:02:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore', 02:02:08 INFO - 'tabpaint']}, 02:02:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore', 02:02:08 INFO - 'tabpaint']}, 02:02:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore', 02:02:08 INFO - 'tabpaint']}, 02:02:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore', 02:02:08 INFO - 'tabpaint']}, 02:02:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore', 02:02:08 INFO - 'tabpaint']}, 02:02:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore', 02:02:08 INFO - 'tabpaint']}, 02:02:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['tsvgx', 02:02:08 INFO - 'tsvgr_opacity', 02:02:08 INFO - 'tart', 02:02:08 INFO - 'tscrollx', 02:02:08 INFO - 'cart', 02:02:08 INFO - 'tsvg_static']}, 02:02:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:02:08 INFO - 'tsvgr_opacity', 02:02:08 INFO - 'tart', 02:02:08 INFO - 'tscrollx', 02:02:08 INFO - 'cart', 02:02:08 INFO - 'tsvg_static']}, 02:02:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:02:08 INFO - 'talos_options': ['--disable-e10s'], 02:02:08 INFO - 'tests': ['tp5o']}, 02:02:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:02:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:02:08 INFO - 'talos_options': ['--disable-e10s', 02:02:08 INFO - '--xperf_path', 02:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:08 INFO - 'tests': ['tp5n']}, 02:02:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:02:08 INFO - 'talos_options': ['--xperf_path', 02:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:08 INFO - 'tests': ['tp5n']}}, 02:02:08 INFO - 'talos.zip': {'path': '', 02:02:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:08 INFO - Running post-action listener: _resource_record_post_action 02:02:08 INFO - [mozharness: 2017-01-09 10:02:08.790243Z] Finished populate-webroot step (success) 02:02:08 INFO - [mozharness: 2017-01-09 10:02:08.790336Z] Running create-virtualenv step. 02:02:08 INFO - Running pre-action listener: _resource_record_pre_action 02:02:08 INFO - Running main action method: create_virtualenv 02:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:08 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 02:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:08 INFO - Using real prefix '/usr' 02:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:11 INFO - Installing pip.................done. 02:02:11 INFO - Return code: 0 02:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:02:11 INFO - Reading from file tmpfile_stdout 02:02:11 INFO - Output received: 02:02:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:02:12 INFO - Using env: {'DISPLAY': ':0', 02:02:12 INFO - 'HOME': '/home/cltbld', 02:02:12 INFO - 'LANG': 'en_US.UTF-8', 02:02:12 INFO - 'LANGUAGE': 'en_US:en', 02:02:12 INFO - 'LOGNAME': 'cltbld', 02:02:12 INFO - 'MAIL': '/var/mail/cltbld', 02:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:12 INFO - 'MOZ_NO_REMOTE': '1', 02:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:12 INFO - 'NO_EM_RESTART': '1', 02:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:12 INFO - 'PWD': '/builds/slave/test', 02:02:12 INFO - 'SHELL': '/bin/bash', 02:02:12 INFO - 'SHLVL': '1', 02:02:12 INFO - 'TERM': 'linux', 02:02:12 INFO - 'TMOUT': '86400', 02:02:12 INFO - 'USER': 'cltbld', 02:02:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:12 INFO - '_': '/tools/buildbot/bin/python'} 02:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:02:12 INFO - Cleaning up... 02:02:12 INFO - Return code: 0 02:02:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:13 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:13 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 02:02:13 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 02:02:13 INFO - Using env: {'DISPLAY': ':0', 02:02:13 INFO - 'HOME': '/home/cltbld', 02:02:13 INFO - 'LANG': 'en_US.UTF-8', 02:02:13 INFO - 'LANGUAGE': 'en_US:en', 02:02:13 INFO - 'LOGNAME': 'cltbld', 02:02:13 INFO - 'MAIL': '/var/mail/cltbld', 02:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:13 INFO - 'MOZ_NO_REMOTE': '1', 02:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:13 INFO - 'NO_EM_RESTART': '1', 02:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:13 INFO - 'PWD': '/builds/slave/test', 02:02:13 INFO - 'SHELL': '/bin/bash', 02:02:13 INFO - 'SHLVL': '1', 02:02:13 INFO - 'TERM': 'linux', 02:02:13 INFO - 'TMOUT': '86400', 02:02:13 INFO - 'USER': 'cltbld', 02:02:13 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:13 INFO - '_': '/tools/buildbot/bin/python'} 02:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:13 INFO - Downloading/unpacking psutil>=3.1.1 02:02:13 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 02:02:13 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 02:02:13 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 02:02:13 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 02:02:13 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 02:02:13 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 02:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:17 INFO - Installing collected packages: psutil 02:02:17 INFO - Running setup.py install for psutil 02:02:17 INFO - building 'psutil._psutil_linux' extension 02:02:17 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 02:02:18 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 02:02:18 INFO - building 'psutil._psutil_posix' extension 02:02:18 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 02:02:18 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 02:02:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:18 INFO - Successfully installed psutil 02:02:18 INFO - Cleaning up... 02:02:18 INFO - Return code: 0 02:02:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:19 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:19 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 02:02:19 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 02:02:19 INFO - Using env: {'DISPLAY': ':0', 02:02:19 INFO - 'HOME': '/home/cltbld', 02:02:19 INFO - 'LANG': 'en_US.UTF-8', 02:02:19 INFO - 'LANGUAGE': 'en_US:en', 02:02:19 INFO - 'LOGNAME': 'cltbld', 02:02:19 INFO - 'MAIL': '/var/mail/cltbld', 02:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:19 INFO - 'MOZ_NO_REMOTE': '1', 02:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:19 INFO - 'NO_EM_RESTART': '1', 02:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:19 INFO - 'PWD': '/builds/slave/test', 02:02:19 INFO - 'SHELL': '/bin/bash', 02:02:19 INFO - 'SHLVL': '1', 02:02:19 INFO - 'TERM': 'linux', 02:02:19 INFO - 'TMOUT': '86400', 02:02:19 INFO - 'USER': 'cltbld', 02:02:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:19 INFO - '_': '/tools/buildbot/bin/python'} 02:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:02:23 INFO - Installing collected packages: mozsystemmonitor 02:02:23 INFO - Running setup.py install for mozsystemmonitor 02:02:23 INFO - Successfully installed mozsystemmonitor 02:02:23 INFO - Cleaning up... 02:02:23 INFO - Return code: 0 02:02:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:02:23 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')]} 02:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:23 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')]} 02:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:25 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:25 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 02:02:25 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 02:02:25 INFO - Using env: {'DISPLAY': ':0', 02:02:25 INFO - 'HOME': '/home/cltbld', 02:02:25 INFO - 'LANG': 'en_US.UTF-8', 02:02:25 INFO - 'LANGUAGE': 'en_US:en', 02:02:25 INFO - 'LOGNAME': 'cltbld', 02:02:25 INFO - 'MAIL': '/var/mail/cltbld', 02:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:25 INFO - 'MOZ_NO_REMOTE': '1', 02:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:25 INFO - 'NO_EM_RESTART': '1', 02:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:25 INFO - 'PWD': '/builds/slave/test', 02:02:25 INFO - 'SHELL': '/bin/bash', 02:02:25 INFO - 'SHLVL': '1', 02:02:25 INFO - 'TERM': 'linux', 02:02:25 INFO - 'TMOUT': '86400', 02:02:25 INFO - 'USER': 'cltbld', 02:02:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:25 INFO - '_': '/tools/buildbot/bin/python'} 02:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:26 INFO - Downloading/unpacking jsonschema==2.5.1 02:02:26 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 02:02:26 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 02:02:26 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 02:02:26 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 02:02:26 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 02:02:26 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 02:02:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:33 INFO - warning: no files found matching '*.txt' 02:02:33 INFO - no previously-included directories found matching 'build' 02:02:33 INFO - no previously-included directories found matching 'dist' 02:02:33 INFO - no previously-included directories found matching '.git*' 02:02:33 INFO - Installing collected packages: jsonschema, functools32 02:02:33 INFO - Running setup.py install for functools32 02:02:33 INFO - warning: no files found matching '*.txt' 02:02:33 INFO - no previously-included directories found matching 'build' 02:02:33 INFO - no previously-included directories found matching 'dist' 02:02:33 INFO - no previously-included directories found matching '.git*' 02:02:33 INFO - Successfully installed jsonschema functools32 02:02:33 INFO - Cleaning up... 02:02:33 INFO - Return code: 0 02:02:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:34 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 02:02:34 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 02:02:34 INFO - Using env: {'DISPLAY': ':0', 02:02:34 INFO - 'HOME': '/home/cltbld', 02:02:34 INFO - 'LANG': 'en_US.UTF-8', 02:02:34 INFO - 'LANGUAGE': 'en_US:en', 02:02:34 INFO - 'LOGNAME': 'cltbld', 02:02:34 INFO - 'MAIL': '/var/mail/cltbld', 02:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:34 INFO - 'MOZ_NO_REMOTE': '1', 02:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:34 INFO - 'NO_EM_RESTART': '1', 02:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:34 INFO - 'PWD': '/builds/slave/test', 02:02:34 INFO - 'SHELL': '/bin/bash', 02:02:34 INFO - 'SHLVL': '1', 02:02:34 INFO - 'TERM': 'linux', 02:02:34 INFO - 'TMOUT': '86400', 02:02:34 INFO - 'USER': 'cltbld', 02:02:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:34 INFO - '_': '/tools/buildbot/bin/python'} 02:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:02:35 INFO - Cleaning up... 02:02:35 INFO - Return code: 0 02:02:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:36 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:36 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 02:02:36 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 02:02:36 INFO - Using env: {'DISPLAY': ':0', 02:02:36 INFO - 'HOME': '/home/cltbld', 02:02:36 INFO - 'LANG': 'en_US.UTF-8', 02:02:36 INFO - 'LANGUAGE': 'en_US:en', 02:02:36 INFO - 'LOGNAME': 'cltbld', 02:02:36 INFO - 'MAIL': '/var/mail/cltbld', 02:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:36 INFO - 'MOZ_NO_REMOTE': '1', 02:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:36 INFO - 'NO_EM_RESTART': '1', 02:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:36 INFO - 'PWD': '/builds/slave/test', 02:02:36 INFO - 'SHELL': '/bin/bash', 02:02:36 INFO - 'SHLVL': '1', 02:02:36 INFO - 'TERM': 'linux', 02:02:36 INFO - 'TMOUT': '86400', 02:02:36 INFO - 'USER': 'cltbld', 02:02:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:36 INFO - '_': '/tools/buildbot/bin/python'} 02:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:02:36 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 02:02:36 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 02:02:36 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 02:02:36 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 02:02:36 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 02:02:36 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 02:02:40 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:40 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 02:02:40 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 02:02:40 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 02:02:40 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 02:02:40 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 02:02:40 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 02:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:41 INFO - Downloading docopt-0.6.1.tar.gz 02:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:41 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:41 INFO - Running setup.py install for blobuploader 02:02:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:41 INFO - Running setup.py install for requests 02:02:41 INFO - Running setup.py install for docopt 02:02:42 INFO - Successfully installed blobuploader requests docopt 02:02:42 INFO - Cleaning up... 02:02:42 INFO - Return code: 0 02:02:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:42 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')]} 02:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:42 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')]} 02:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:43 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:43 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 02:02:43 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 02:02:43 INFO - Using env: {'DISPLAY': ':0', 02:02:43 INFO - 'HOME': '/home/cltbld', 02:02:43 INFO - 'LANG': 'en_US.UTF-8', 02:02:43 INFO - 'LANGUAGE': 'en_US:en', 02:02:43 INFO - 'LOGNAME': 'cltbld', 02:02:43 INFO - 'MAIL': '/var/mail/cltbld', 02:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:43 INFO - 'MOZ_NO_REMOTE': '1', 02:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:43 INFO - 'NO_EM_RESTART': '1', 02:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:43 INFO - 'PWD': '/builds/slave/test', 02:02:43 INFO - 'SHELL': '/bin/bash', 02:02:43 INFO - 'SHLVL': '1', 02:02:43 INFO - 'TERM': 'linux', 02:02:43 INFO - 'TMOUT': '86400', 02:02:43 INFO - 'USER': 'cltbld', 02:02:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:43 INFO - '_': '/tools/buildbot/bin/python'} 02:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:43 INFO - Running setup.py (path:/tmp/pip-RdL5y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:43 INFO - Running setup.py (path:/tmp/pip-5okr9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:43 INFO - Running setup.py (path:/tmp/pip-FXHflq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:43 INFO - Running setup.py (path:/tmp/pip-Wi8Odt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:43 INFO - Running setup.py (path:/tmp/pip-6RGEog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:43 INFO - Running setup.py (path:/tmp/pip-CjkXlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:43 INFO - Running setup.py (path:/tmp/pip-y1taqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:43 INFO - Running setup.py (path:/tmp/pip-3uzAdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:43 INFO - Running setup.py (path:/tmp/pip-OuleMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:43 INFO - Running setup.py (path:/tmp/pip-tqCiFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:44 INFO - Running setup.py (path:/tmp/pip-96t65G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:44 INFO - Running setup.py (path:/tmp/pip-rEUxpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:44 INFO - Running setup.py (path:/tmp/pip-0BYR1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:44 INFO - Running setup.py (path:/tmp/pip-I3RTa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:44 INFO - Running setup.py (path:/tmp/pip-e6RTJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:44 INFO - Running setup.py (path:/tmp/pip-auXeNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:44 INFO - Running setup.py (path:/tmp/pip-M4ZEYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:44 INFO - Running setup.py install for manifestparser 02:02:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:44 INFO - Running setup.py install for mozcrash 02:02:44 INFO - Running setup.py install for mozdebug 02:02:44 INFO - Running setup.py install for mozdevice 02:02:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:44 INFO - Running setup.py install for mozfile 02:02:45 INFO - Running setup.py install for mozhttpd 02:02:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozinfo 02:02:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozInstall 02:02:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozleak 02:02:45 INFO - Running setup.py install for mozlog 02:02:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for moznetwork 02:02:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozprocess 02:02:45 INFO - Running setup.py install for mozprofile 02:02:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozrunner 02:02:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:46 INFO - Running setup.py install for mozscreenshot 02:02:46 INFO - Running setup.py install for moztest 02:02:46 INFO - Running setup.py install for mozversion 02:02:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:46 INFO - Cleaning up... 02:02:46 INFO - Return code: 0 02:02:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:46 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')]} 02:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:46 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')]} 02:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:47 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:47 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 02:02:47 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 02:02:47 INFO - Using env: {'DISPLAY': ':0', 02:02:47 INFO - 'HOME': '/home/cltbld', 02:02:47 INFO - 'LANG': 'en_US.UTF-8', 02:02:47 INFO - 'LANGUAGE': 'en_US:en', 02:02:47 INFO - 'LOGNAME': 'cltbld', 02:02:47 INFO - 'MAIL': '/var/mail/cltbld', 02:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:47 INFO - 'MOZ_NO_REMOTE': '1', 02:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:47 INFO - 'NO_EM_RESTART': '1', 02:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:47 INFO - 'PWD': '/builds/slave/test', 02:02:47 INFO - 'SHELL': '/bin/bash', 02:02:47 INFO - 'SHLVL': '1', 02:02:47 INFO - 'TERM': 'linux', 02:02:47 INFO - 'TMOUT': '86400', 02:02:47 INFO - 'USER': 'cltbld', 02:02:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:47 INFO - '_': '/tools/buildbot/bin/python'} 02:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:47 INFO - Running setup.py (path:/tmp/pip-tBtOVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:47 INFO - Running setup.py (path:/tmp/pip-KNRzHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:47 INFO - Running setup.py (path:/tmp/pip-kGpn1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:47 INFO - Running setup.py (path:/tmp/pip-it22OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:47 INFO - Running setup.py (path:/tmp/pip-dH4L_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:47 INFO - Running setup.py (path:/tmp/pip-eZEQ49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:47 INFO - Running setup.py (path:/tmp/pip-sh1oUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:47 INFO - Running setup.py (path:/tmp/pip-2PGNNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:47 INFO - Running setup.py (path:/tmp/pip-FIKfri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:47 INFO - Running setup.py (path:/tmp/pip-S9x34g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:48 INFO - Running setup.py (path:/tmp/pip-6X5bB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:48 INFO - Running setup.py (path:/tmp/pip-cUdrmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:48 INFO - Running setup.py (path:/tmp/pip-A34TTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:48 INFO - Running setup.py (path:/tmp/pip-cZnIty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:48 INFO - Running setup.py (path:/tmp/pip-_FWvNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:48 INFO - Running setup.py (path:/tmp/pip-D_pEVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:48 INFO - Running setup.py (path:/tmp/pip-4Ir_D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:51 INFO - Downloading blessings-1.6.tar.gz 02:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:52 INFO - Installing collected packages: blessings 02:02:52 INFO - Running setup.py install for blessings 02:02:52 INFO - Successfully installed blessings 02:02:52 INFO - Cleaning up... 02:02:52 INFO - Return code: 0 02:02:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:52 INFO - Reading from file tmpfile_stdout 02:02:52 INFO - Current package versions: 02:02:52 INFO - argparse == 1.2.1 02:02:52 INFO - blessings == 1.6 02:02:52 INFO - blobuploader == 1.2.4 02:02:52 INFO - docopt == 0.6.1 02:02:52 INFO - functools32 == 3.2.3-2 02:02:52 INFO - jsonschema == 2.5.1 02:02:52 INFO - manifestparser == 1.1 02:02:52 INFO - mozInstall == 1.12 02:02:52 INFO - mozcrash == 1.0 02:02:52 INFO - mozdebug == 0.1 02:02:52 INFO - mozdevice == 0.49 02:02:52 INFO - mozfile == 1.2 02:02:52 INFO - mozhttpd == 0.7 02:02:52 INFO - mozinfo == 0.9 02:02:52 INFO - mozleak == 0.1 02:02:52 INFO - mozlog == 3.4 02:02:52 INFO - moznetwork == 0.27 02:02:52 INFO - mozprocess == 0.24 02:02:52 INFO - mozprofile == 0.28 02:02:52 INFO - mozrunner == 6.13 02:02:52 INFO - mozscreenshot == 0.1 02:02:52 INFO - mozsystemmonitor == 0.3 02:02:52 INFO - moztest == 0.8 02:02:52 INFO - mozversion == 1.4 02:02:52 INFO - psutil == 3.1.1 02:02:52 INFO - requests == 1.2.3 02:02:52 INFO - wsgiref == 0.1.2 02:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:52 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')]} 02:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:52 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')]} 02:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:53 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 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02:53 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 02:02:53 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 02:02:53 INFO - Using env: {'DISPLAY': ':0', 02:02:53 INFO - 'HOME': '/home/cltbld', 02:02:53 INFO - 'LANG': 'en_US.UTF-8', 02:02:53 INFO - 'LANGUAGE': 'en_US:en', 02:02:53 INFO - 'LOGNAME': 'cltbld', 02:02:53 INFO - 'MAIL': '/var/mail/cltbld', 02:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:53 INFO - 'MOZ_NO_REMOTE': '1', 02:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:53 INFO - 'NO_EM_RESTART': '1', 02:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:53 INFO - 'PWD': '/builds/slave/test', 02:02:53 INFO - 'SHELL': '/bin/bash', 02:02:53 INFO - 'SHLVL': '1', 02:02:53 INFO - 'TERM': 'linux', 02:02:53 INFO - 'TMOUT': '86400', 02:02:53 INFO - 'USER': 'cltbld', 02:02:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:53 INFO - '_': '/tools/buildbot/bin/python'} 02:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 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)) 02:02:53 INFO - Cleaning up... 02:02:53 INFO - Return code: 0 02:02:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, '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': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', '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 02:02: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', 'jsonschema'] in /builds/slave/test/build 02:02: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 jsonschema 02:02:55 INFO - Using env: {'DISPLAY': ':0', 02:02:55 INFO - 'HOME': '/home/cltbld', 02:02:55 INFO - 'LANG': 'en_US.UTF-8', 02:02:55 INFO - 'LANGUAGE': 'en_US:en', 02:02:55 INFO - 'LOGNAME': 'cltbld', 02:02:55 INFO - 'MAIL': '/var/mail/cltbld', 02:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:55 INFO - 'MOZ_NO_REMOTE': '1', 02:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:55 INFO - 'NO_EM_RESTART': '1', 02:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:55 INFO - 'PWD': '/builds/slave/test', 02:02:55 INFO - 'SHELL': '/bin/bash', 02:02:55 INFO - 'SHLVL': '1', 02:02:55 INFO - 'TERM': 'linux', 02:02:55 INFO - 'TMOUT': '86400', 02:02:55 INFO - 'USER': 'cltbld', 02:02:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:55 INFO - '_': '/tools/buildbot/bin/python'} 02:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:55 INFO - Cleaning up... 02:02:55 INFO - Return code: 0 02:02:55 INFO - Running post-action listener: _resource_record_post_action 02:02:55 INFO - Running post-action listener: _start_resource_monitoring 02:02:55 INFO - Starting resource monitoring. 02:02:55 INFO - [mozharness: 2017-01-09 10:02:55.839407Z] Finished create-virtualenv step (success) 02:02:55 INFO - [mozharness: 2017-01-09 10:02:55.839909Z] Running install step. 02:02:55 INFO - Running pre-action listener: _resource_record_pre_action 02:02:55 INFO - Running main action method: install 02:02:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:56 INFO - Reading from file tmpfile_stdout 02:02:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:56 INFO - Reading from file tmpfile_stdout 02:02:56 INFO - Output received: 02:02:56 INFO - Usage: mozinstall [options] installer 02:02:56 INFO - Options: 02:02:56 INFO - -h, --help show this help message and exit 02:02:56 INFO - -d DEST, --destination=DEST 02:02:56 INFO - Directory to install application into. [default: 02:02:56 INFO - "/builds/slave/test"] 02:02:56 INFO - --app=APP Application being installed. [default: firefox] 02:02:56 INFO - mkdir: /builds/slave/test/build/application 02:02:56 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'] 02:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:03:12 INFO - Reading from file tmpfile_stdout 02:03:12 INFO - Output received: 02:03:12 INFO - /builds/slave/test/build/application/firefox/firefox 02:03:12 INFO - Running post-action listener: _resource_record_post_action 02:03:12 INFO - [mozharness: 2017-01-09 10:03:12.258172Z] Finished install step (success) 02:03:12 INFO - [mozharness: 2017-01-09 10:03:12.258448Z] Running run-tests step. 02:03:12 INFO - Running pre-action listener: _resource_record_pre_action 02:03:12 INFO - Running main action method: run_tests 02:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:12 INFO - Python 2.7.3 02:03:12 INFO - Return code: 0 02:03:12 INFO - grabbing minidump binary from tooltool 02:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:03:12 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 0x1c40850>, '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 0x1bb56d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:12 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 02:03:12 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 02:03:12 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 02:03:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:12 INFO - Return code: 0 02:03:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:03:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:03:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 02:03:12 INFO - Using env: {'DISPLAY': ':0', 02:03:12 INFO - 'HOME': '/home/cltbld', 02:03:12 INFO - 'LANG': 'en_US.UTF-8', 02:03:12 INFO - 'LANGUAGE': 'en_US:en', 02:03:12 INFO - 'LOGNAME': 'cltbld', 02:03:12 INFO - 'MAIL': '/var/mail/cltbld', 02:03:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:12 INFO - 'MOZ_NO_REMOTE': '1', 02:03:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:12 INFO - 'NO_EM_RESTART': '1', 02:03:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:12 INFO - 'PWD': '/builds/slave/test', 02:03:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:12 INFO - 'SHELL': '/bin/bash', 02:03:12 INFO - 'SHLVL': '1', 02:03:12 INFO - 'TERM': 'linux', 02:03:12 INFO - 'TMOUT': '86400', 02:03:12 INFO - 'USER': 'cltbld', 02:03:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937', 02:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:12 INFO - '_': '/tools/buildbot/bin/python'} 02:03:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:03:12 INFO - mozversion application_buildid: 20170109093217 02:03:12 INFO - mozversion application_changeset: 97896f92f196462e0072f8304b97c29217da1327 02:03:12 INFO - mozversion application_display_name: Nightly 02:03:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:12 INFO - mozversion application_name: Firefox 02:03:12 INFO - mozversion application_remotingname: firefox 02:03:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:03:12 INFO - mozversion application_vendor: Mozilla 02:03:12 INFO - mozversion application_version: 53.0a1 02:03:12 INFO - mozversion platform_buildid: 20170109093217 02:03:12 INFO - mozversion platform_changeset: 97896f92f196462e0072f8304b97c29217da1327 02:03:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:03:12 INFO - mozversion platform_version: 53.0a1 02:03:12 INFO - using testdate: 1483956192 02:03:12 INFO - actual date: 1483956192 02:03:12 INFO - starting webserver on 'localhost:55518' 02:03:12 INFO - SUITE-START | Running 2 tests 02:03:12 INFO - TEST-START | dromaeo_css 02:03:12 INFO - operating with platform_type : linux_ 02:03:12 INFO - Initialising browser for dromaeo_css test... 02:03:12 INFO - TEST-INFO | started process 12547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSfATz/profile http://localhost:55518/getInfo.html) 02:03:13 INFO - PROCESS | 12547 | 1483956193022 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 02:03:16 INFO - PROCESS | 12547 | __metrics Screen width/height:1600/1200 02:03:16 INFO - PROCESS | 12547 | colorDepth:24 02:03:16 INFO - PROCESS | 12547 | Browser inner width/height: 1024/697 02:03:16 INFO - PROCESS | 12547 | __metrics 02:03:17 INFO - PROCESS | 12547 | 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" 02:03:17 INFO - PROCESS | 12547 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:03:17 INFO - PROCESS | 12547 | console.error: PushService: 02:03:17 INFO - PROCESS | 12547 | stateChangeProcessEnqueue: Error transitioning state 02:03:17 INFO - PROCESS | 12547 | UnknownError 02:03:18 INFO - TEST-INFO | 12547: exit 0 02:03:18 INFO - Browser initialized. 02:03:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:18 INFO - TEST-INFO | started process 12629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSfATz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:30 INFO - PROCESS | 12629 | RSS: Main: 152473600 02:03:30 INFO - PROCESS | 12629 | 02:06:35 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55518/tests/dromaeo/cssquery-ext.html) 02:06:37 INFO - PROCESS | 12629 | RSS: Main: 253927424 02:06:37 INFO - PROCESS | 12629 | 02:08:18 INFO - PROCESS | 12629 | ************************* 02:08:18 INFO - PROCESS | 12629 | A coding exception was thrown and uncaught in a Task. 02:08:18 INFO - PROCESS | 12629 | 02:08:18 INFO - PROCESS | 12629 | Full message: ReferenceError: fetch is not defined 02:08:18 INFO - PROCESS | 12629 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 02:08:18 INFO - PROCESS | 12629 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 02:08:18 INFO - PROCESS | 12629 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 02:08:18 INFO - PROCESS | 12629 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:08:18 INFO - PROCESS | 12629 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:08:18 INFO - PROCESS | 12629 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:08:18 INFO - PROCESS | 12629 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 02:08:18 INFO - PROCESS | 12629 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:08:18 INFO - PROCESS | 12629 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:08:18 INFO - PROCESS | 12629 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:08:18 INFO - PROCESS | 12629 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 02:08:18 INFO - PROCESS | 12629 | 02:08:18 INFO - PROCESS | 12629 | ************************* 02:09:39 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-ext.html (next: http://localhost:55518/tests/dromaeo/cssquery-jquery.html) 02:09:40 INFO - PROCESS | 12629 | RSS: Main: 246697984 02:09:40 INFO - PROCESS | 12629 | 02:12:42 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55518/tests/dromaeo/cssquery-mootools.html) 02:12:43 INFO - PROCESS | 12629 | RSS: Main: 223821824 02:12:43 INFO - PROCESS | 12629 | 02:15:45 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55518/tests/dromaeo/cssquery-prototype.html) 02:15:46 INFO - PROCESS | 12629 | RSS: Main: 197976064 02:15:46 INFO - PROCESS | 12629 | 02:18:49 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55518/tests/dromaeo/cssquery-yui.html) 02:18:49 INFO - PROCESS | 12629 | RSS: Main: 184389632 02:18:49 INFO - PROCESS | 12629 | 02:21:52 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-yui.html (next: http://localhost:55518/tests/dromaeo/cssquery-dojo.html) 02:21:53 INFO - PROCESS | 12629 | RSS: Main: 278573056 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | __start_tp_report 02:21:53 INFO - PROCESS | 12629 | _x_x_mozilla_page_load 02:21:53 INFO - PROCESS | 12629 | _x_x_mozilla_page_load_details 02:21:53 INFO - PROCESS | 12629 | |i|pagename|runs| 02:21:53 INFO - PROCESS | 12629 | |0;dojo.html;2600.5319042572337;2605.531004419204;2611.38632421381;2636.446346267284;2641.0492222799776;4731.952680473194;4767.046590681869;4827.106985207739;4859.198232291672;4868.51314868513;4813.037392521501;4815.277708343741;4851.345068415762;4863.562279394854;4904.190808516591;4373.759443230637;4410.647148228134;4439.112177564484;4506.121306345264;4543.204939135655;4102.118044620406;4445.755483448425;4494.786407669943;4540.02389486262;4580.862574122782;4378.8029538670835;4498.797554110073;4524.864254072383;4539.841105561306;4614.653900957424;4353.84761533348;4366.956330436687;4385.912281754379;4425.955740442619;4461.219286624828;4402.647788176938;4405.449318835145;4410.16206920684;4449.243628583149;4471.508134105278;4757.286407038937;4811.735354555498;4822.445418776815;4829.637777166727;4875.804967801284;5061.316722242524;5087.49125087492;5142.357205349332;5159.251908473288;5184.948150518484;5229.477052294778;5231.9476805232225;5241.554467870235;5255.842324730226;5272.261883336336;4875.585575226146;4880.072786170652;4892.51074892515;4895.167821470359;4927.113119638428;5260.763265653055;5284.180951952453;5305.4164041955355;5340.786368545292;5360.0351936650995;5055.747212639353;5111.846644600668;5130.7947682093045;5167.896642067138;5181.663191892515;5053.84838454847;5090.541851233407;5196.194589838506;5213.191955246867;5217.791288348423;5089.109405853961;5096.566791822663;5138.126518491866;5138.409082955508;5175.844724658266;5061.544460998528;5124.641275110781;5129.717865517432;5135.35808023997;5142.717150556755;4401.823927042947;4424.358468022118;4453.465584129925;4453.643708503312;4455.04216593434;3824.7513911595656;3863.2466668999277;3886.1256217351433;3895.6493915547735;3912.39357899526;4523;4527.230370836965;4528.184926713223;4578.313253012075;4585.72485650862;5072.923906141411;5283.709395983258;5284.603654725911;5296.09966305729;5296.602754793406;4419.977900110479;4459.130469558405;4502.369668246448;4503.797329120198;4562;4721.173794585934;4721.905561888743;4727.64542659302;4732.810687572527;4771.761411929389;4912.23860301661;4914.5576898078625;4924.76196155612;4926;4979.850604481871;5101.92347114801;5113.821016264413;5118.104331741856;5126.7180305083575;5150.948490515047;4829.492903245108;4829.806807727651;4832.057748738962;4867.245576935581;4879.512048795092;5014.974925125351;5047.697138171721;5053.242013697828;5058.342415485963;5067.189249720027;5055;5071.594272458268;5075.441701412916;5134.7946082156295;5172.818951336685;5064.5948324134715;5083.034223497523;5088.465711100281;5137.049645815536;5140.56305214061;4940.9505904941925;5074.3657042869645;5080.771365288645;5087.389513258433;5129.538341549279;4912.729799861042;4944.035912996931;4996.325496057985;5000.924986125138;5002.424721156968;5072.416672082758;5093.8726531837;5103.387593488656;5141.922871156861;5156.948430515797;4957.752112394293;4967.627427942846;4971.030649023406;4971.37857767779;5019.196928491424 02:21:53 INFO - PROCESS | 12629 | |1;ext.html;519.8960207958409;527.6491133396291;535.2880668710612;537.3363895588949;538.8922215556889;29615.111546653607;31997.680023199762;34091.659083409155;34985;35281.11797205071;40859.795701021525;41222.38166427506;41249.58750412495;41305.79347103268;41316.17367652645;7597.81005474862;7776.688932442696;7777.066751989769;7782.105057918356;7787.104482984472;7434.256574342549;7602.771916842504;7785.065792104955;7789.221077892222;7977.60111994398;10002.149817265541;10229.335093218917;10231.693049208536;10552.103071238915;10555.261131720783;9702.175315098226;9774.902250977542;9777;9785.804283914282;9799.608015679365;9978.451185184811;10063;10063.24525660571;10068.949655251678;10070.496475176285;38787.41818872719;38941.22117557661;39308;39320.606793931984;39327.21345573101;3650.7992060436663;3761.6238376162437;3782.014442417725;3817.541894972593;3840.7311488195837;28979.56530652042;29086.70913290861;29128.854355728297;29367.412651747058;29970.55044174339;3429.4341433663417;3432.1934345428804;3448.9482657760154;3489.1277180704824;3530.6645868642436;246474;246513;247509;247996;248524.9999999982;54060;54448;54469.45530544644;54516.45483545193;54570.177368074124;57474;57545.83497907571;57546.424535754944;57554.42445575575;57638.71180644154;14069.01516893828;14577.489787857374;14589.85410145885;14629.707405851823;14677.55967320982;11032.613858514913;11079.50142243585;11116.833247501294;11121.666350009513;11122.888771112348;12985.506666733258;13445;14503.187101612299;14711.926440367944;16477.505674829776;5747.770089196469;5819.388964158787;5850.64896106235;5937.52499800015;5968;781.9804504887423;782.2529484342439;787.7794217619075;802.8880001198382;804.5333706450361;26281.00660874466;26947.73052269452;27045.594316085273;27124.59313110305;27390.863045684644;975.2295686407658;975.2782940623887;979.7648564344648;992.8709267795285;1019.0421004255976;13568.1859088455;14333.283335833166;14503.492377766728;14681.339339729739;14780.556583302303;343923;347107;347709;347892;348514;45252.77373613111;46014;46071.539284607396;49908;50938;1185.916985810985;1237.6843904804218;1253.7931241345075;1258.6916205529521;1259.7291582309665;27688;28719.85640071786;29001.41997160003;29808.254793629465;29858.701412985592;43340.34989475097;43925.12149757051;43959.340609891515;43972.34041489444;43979.78010110057;312532;312702;313430;314018;314319.85441164195;24623.507529848943;24789.50420991606;25133.497330053662;25157;25171.87414062918;36940.44589331109;37422.84485748019;41399.7930010348;41915.371269430376;41942.16115677731;33545.859732576384;36014.639853601126;36405.27189456249;36816.44775328319;37162;34861.12847178841;35325.82337088298;35363.29273414569;35599.28801424009;35821.641783582876;34252.48621270733;34365.14087147841;34606;35043.82478087695;35179.472307915916;29828.403431931674;30849;31911.84044079765;32214.355712885143;32313.676863231067;24003.27990160298;24254.757452425954;24369.756302437458;24646;24689.382765431008 02:21:53 INFO - PROCESS | 12629 | |2;jquery.html;366.50704802041247;368.6276860371025;372.3762697481718;381.80146323911583;392.75256588349356;17084.145792710362;17741;17752.55618609532;17922.64154716905;18136.18387172577;17083.572910677238;17100.914495427536;17468.56328591786;17557.91221043893;17607.950171460572;5057.342545469093;5200.193969934648;5229.607779416559;5235.973820130913;5247.239150323201;5032.899342013157;5079.847604571869;5104.974475127619;5128.230765385185;5130.07658621448;5107;5110.821121260757;5113.974430127844;5119.411267704206;5121.66709163905;5085.262636917645;5099.745012749367;5279.551238144743;5389.51494365509;5461.972690136564;5417.187421886709;5433.130699088167;5455.645383050129;5485.122380419154;5496.1755736639425;12099.818502722379;12439.440225189797;12492.500299987989;12541.623751287385;12544.059195560278;2406.1458182345364;2455.742147074567;2471.913483028103;2505.2985164154065;2544.8982040718347;8650.783730406727;8693.565321733888;8951.641934322619;9159.954200228956;9294.628214871396;1685.0647890420812;1692.627621923175;1703.2590822992038;1725.5082301544;1729.9135043247786;77915.05212369736;78240.21759782387;78837.41507821072;82614;82778;9663.758406039764;9829.705108846745;10036.347637403545;10047.346922450017;10147.644832430977;13554.322283885964;13567.52513662017;13573.253471059186;13579.388927498287;13606.047576669736;7163.7492687755675;7230.710771569184;7237.384822290059;7450.292222238879;7490.363319117827;6675.566088204251;6720.899186512206;6959.930400696029;6989.30106989297;7098.36114749675;4288.699791014661;4407.625351845065;4430.601245887886;4504.527024662429;4546.090781843578;1721.7159168737269;1780.7740324594258;1786.330126202674;1792.1755992243454;1856.1183437866905;877.5305211711831;891.6789955615973;895.3329769321897;915.0986278515657;937.3438592984937;17224.990379473606;17975.191116399794;18174.5456363592;18301.450956471326;18437.1703273353;852.8336974289954;854.4104567848165;866.4714524140269;871.9694810681596;886.0386480668418;8920.643174273086;9839.114479696718;9915.504224788732;9964.402135871871;9985.45080020606;533934;548627;574231;574309;588932;73106;77153;84362.57818710867;95373.04626953781;98030.5098474503;988.8170688422665;1009.9596016159271;1024.7847951930178;1033.3334998925802;1033.9017793309624;15742.212889355715;16049.839501605302;16080.67838643244;17110.572235693708;17155.485335439957;31094.844525777225;34295.142621434665;38723;38738.80630596829;39554.2089158221;50886.74556627193;52216.21675674944;55427;56293.43706563046;57086.42913570811;7645.5794931279315;7743.651535680795;7820.569868657279;7839.059312882263;7999.400044996532;11911.82132268034;12188.817167742669;12532.874671253536;12813.487460501476;13172.07795454309;7243.45674074436;7314.232005639331;9850.064243896819;10425.895741042492;10673.626423075155;7173.1392232932385;7541.924580754122;7725.652345644572;7887.698529742528;8066.193380661887;6909;6920.9653951729915;7004.4396448283;7386.2244464332625;7544.886826697494;12234.449449774604;12314.79815248024;12343.13598048128;12535.686607834878;12592.433340499516;10321.329113607591;10706.571737130427;10821.9458902705;10930.125589952944;10945.45272736376 02:21:53 INFO - PROCESS | 12629 | |3;mootools.html;1239.1945235596866;1338.8527262001178;1348.554976857637;1354.9661258468543;1363.5023216525965;6427.614343139409;6817.931820681792;7043.894341584881;7065.046218760473;7180.569165850053;7132.964335178317;7170.498065135443;7193.8561228775525;7194.424446044317;7202.171750248723;1842.1710230396309;1903.828655421012;2065.5765568058514;2094.937151885438;2098.5278312379746;2057.6913462980524;2129.9041543130597;2131.7761635028332;2145.8068773810355;2147.119680930811;2016.5059560407647;2032.634125857345;2039.2862498125612;2039.377989713137;2039.6634555298358;2028.2292728762975;2033.1054336092072;2034.9287774927807;2036.6232247034345;2055.321743824542;2002.8297594704322;2039.2862498125685;2055.126571207246;2057.1565658080117;2059.4748339173566;7038.085048943656;7152.856942861114;7154.856902861914;7165.89251161233;7234.927650723531;4325.178216138955;4377.562243775629;4378.211921854065;4380.649548036149;4380.649548036149;2634.2492389669046;2716.9456610867674;2754.9173524794287;2804.551271796523;2806.9438611227865;935.714607044851;958.8417911044669;976.6532880827275;981.8870829854516;1004.2869562610555;9216.677416290464;9314.487703176323;9331.16019558243;9343.906560934372;9359;3811.961880381161;3868.7678739275734;3989.940150897739;4046.291898917678;4064.6748260139116;8275.751727448187;8280.544570048705;8302.335813134934;8303.584820758937;8420.242178203991;4442.822287108479;4450.418757120862;4451.287793952952;4458.152950939311;4506.549345065533;3621.3843646580144;3691.206390626028;3964.801759911993;4100.856470023595;4111.259973204792;3336.115929278743;3362.81504517249;3498.8250587470525;3507.8421471033867;3509.701675357623;1047.1570385839473;1049.2969710294121;1059.8304271316551;1071.8874518175635;1080.9243352965218;837.8910741603675;838.2748922182268;850.8213275212274;861.9396642234983;872.4547158026234;4593.425821772278;4890.755462226874;4913.533214344703;4914.164592019365;5058.468860769566;863.7365603490996;916.3860213656866;918.4397517514311;919.5494207838245;933.5658918602746;3222.9838850805595;3237.4496335623003;3300.174956260935;3376.122208225879;3406.710429613461;8475.27960123384;8487.448315859448;8523.48859068458;8622.051574326819;8667;8504.617292221865;8562.100979397073;8613.827723445496;8622.137786221328;8630.482171069756;6764.763233286812;6813.965930170318;6814;6814.420774234147;6817.897731534031;4731.621470282438;4777.378940737682;4836.081144582518;4862.07620552094;4877.439094504036;7686.192949740421;7792.415568832247;7849;7869.724559640385;7917.168697286702;7682.7311044113185;8051.2351326623875;8054.597270136587;8068.354531637572;8071.112177660335;5593.580481463825;5746.626469279484;6167.074938759042;6257.812265632038;6313.273973493107;6502.219733631805;6661.933380666132;6690.632015239208;6881.724731010703;6882.139732533434;5879.18713934045;5999.350178700718;6065.181200538047;6145.600535965148;6158.753649853956;6034.24571928509;6042.818715438544;6050.092486127116;6066.423689749467;6087.969560152171;5206.193040078794;5235.3717553893775;5240.292560504436;5246.134387826119;5264.078786212474;4160.375943608483;4179.853705120307;4292.227399068198;4293.720908140961;4351.934720979125;4206.72656277341;4225.471816022997;4238.131183107517;4241.533431322614;4346.543612920725 02:21:53 INFO - PROCESS | 12629 | |4;prototype.html;338.93390788796177;347.48225144534644;354.35861091424516;356.87687747727057;359.48593511278875;4654.348391225231;4787.80848766049;4885.951140488594;4909.140900342439;4916.410030796305;4694.577488026077;4778.327585345128;4812.8074877004965;4832.879178020543;4833.45329494561;3886.6113388661047;3900.5514365847866;3918.804059797013;3920.843351211385;3926.5680775114715;3687.907802304937;3819.598942111066;3881.165549406877;3912.628300311466;3913.628205320504;3757.755745876509;3815.4849095372047;3842.9423558646645;3845.634664706862;3868.3946162342595;3821.14024344523;3827.770333779982;3829.1193025604266;3835;3849.845046486043;3471.6701913318193;3479.799469183153;3483.251101013269;3485.7037151842123;3486.9476957845654;4579.954200457986;4681.852946028245;4689.906201875943;4705.364995602439;4763.095011947719;4398.626116780078;4399.186150562156;4407.669424793121;4409.426774519324;4414.381986521889;5041.546260836506;5047.899042019139;5057.342545469102;5087.440381558025;5091.287219789232;3713.60739722604;3776.4146557283666;3813.904652383713;3816.732828701992;3831.9233615327817;5266.657667251617;5270.183121616155;5275.551578115865;5279.52484276417;5292.68243905363;3882.107115363482;3885.8445662173194;3886.3976083706507;3890.766554006712;3895.7662540247675;3835.6739677127757;3957.604239576019;3967.6032396760093;3981.5023122109737;3991.1818077294083;4384.8246070157475;4388.144311859221;4402.471703395613;4406.33904914259;4411.823527058882;5055.368078990126;5055.443901170868;5061.8734531637;5086.77109530072;5088.974555127201;1222.0712258683463;1251.8873301402734;1311.8097875807955;1322.2066759943957;1324.6158614002024;902.4314681750456;914.4500072377257;919.4529255093208;925.9953700231456;926.2775035472208;4363.781810909441;4365.541618130051;4389.626881715026;4392.582704643054;4415.2935530315635;4827.348307978378;5074.3657042869645;5079.466656001066;5112.923306150411;5119.389111553135;4310.374995625617;4343.3484977253665;4375.759333236639;4379.386885835986;4379.737215767001;2662.1614191529607;2682.7183145769804;2683.510651588387;2685.3018215264174;2685.5837345211526;4735.881602959954;4752.7861246244;4770;4783;4803.423589169252;5043.621728370387;5328.6802791832615;5352.464753524694;5363.678179309254;5365.248865158803;4914.459409464956;4917.918058027229;4928.753562321869;4931.18635425158;4938.234573641092;4946.9364086721525;5210.400803907599;5213.426523082382;5215.401373052581;5228.58171346299;5124.410692770379;5138.922916156186;5144.536991670768;5168.896622067613;5170.663906846043;4890.364252647133;4902.975485122552;4909.214525675875;4917.434495033117;4935.679180853233;3558.893233203008;3633.3459977204357;3640.9635903640624;3660.213054193361;3685.9078523037138;5184.559312458483;5192.324997750268;5196.610254231024;5204.687718736888;5222.29499017643;5037.244413338029;5049.31834202378;5059.898802024012;5068.265101560327;5084.2881996521255;4814.662973591955;5054.21659642756;5070.8225212117395;5078.7206703631655;5093.71984540839;4822.638302127284;4864.878378040577;4904.950950490449;5001.574866136273;5003.374578177728;5013.02246062029;5046.9747651261505;5067.945643485124;5081.7713202905215;5101.336826212569;4932.087563800565;4946.703197808143;4956.3804524434445;4956.430010548833;4970.975145124251 02:21:53 INFO - PROCESS | 12629 | |5;yui.html;636.4685487617838;645.0356716708521;718.996999186135;747.6448686873734;760.8554374668814;13096.214227146365;13756.174629522237;13811.723765524695;13831.515896943609;13844.238566878817;13455.327233638303;13555.118917270394;13575.185488870675;13612;13663;660.0660066006595;678.2064983968768;773.2383602151876;792.3621484704811;793.305857374797;790.4348390900504;792.0851416613821;792.6116203060487;792.7066985215479;793.1473665809249;838.9412741108125;839.03091928822;839.0560619303284;839.8530257204995;839.9958000210021;688.1192074145127;699.814549144472;708.0582824842946;709.2588245283691;830.7923019245188;522.7151202594595;592.0586267834165;607.3440684061203;612.4182027074297;614.5483069943588;12629.179103358345;12682.682932926751;12685.873141268561;12702.237865727993;12708.745825083446;12383.380830958506;12633.684157896034;12711.936440317832;12961.935190324082;13047.608571742769;11705.361249425086;11751.294922304689;11831.763364732657;12110.091743119301;12138;3998.6001399860074;4004.4593979812644;4026.4966879140106;4208.242516347056;4216.262154123016;57953.710231449;59339.40660593425;59731;60161;60965.390346096414;10113.29206955506;10155.527448519922;10265.640702575374;10289.2797504174;10409.739756505996;19093.331733389543;19183.52041198981;19214.13536390866;19348.903255483634;19416.514587135436;6856.24581296057;6931;6942.340477654615;7037.454056654755;7193.9280607194305;3652.5616925969052;3657.213699054716;3669.082729317671;3680.8895733127515;3737.289914916157;2617.175589689242;2682.651255336833;3207.246297120175;3353.2790450052867;3441.862325507002;529.0978881007873;538.0825692194799;539.7544117426562;542.7855996881289;550.0950935710733;636.2651137935692;653.2063542795527;660.5504587155963;668.6623255256064;669.397542212013;8754.262547992656;8877.422967507091;8998.14517620825;9060;9061.637534498677;631.5246810155959;653.1600837791939;654.4764188649157;660.9471242300605;666.3469799596422;3957.821898014596;4189.76651763537;4301.440812694393;4379.321205213197;4385.342198670225;68527.31472685309;68741.3125868745;69090;69761;70965.29034709587;48286.27570586444;57518.712406438535;57936.71031644899;57939.71030144822;58722.70638646779;40324;46551.30173047407;47322.526774731814;48960;50005.49994500008;9287.582058807235;9829.508524573599;9839.868415132352;9858.11276985046;9985.101340879355;32058.19854503656;34387.82806085954;34990.12524686903;35221.471677925365;35653.28693426169;42093.36859947164;42273;42466.78766606147;44458.55541444544;44881.55118448904;10634.149268058381;10712.196585256293;10882.40146791934;10901.182411319025;11039.227254092137;12767.93616031914;12957.676058098623;13082.672933176747;13603.591892243248;14042;11729.35488548138;12396;13008.349582521025;13144.27706476153;13283.80074298867;11832.112456928495;12329.136960412685;12450.315232662291;12548.749025019266;12607.810882836948;11923.105767067678;11994.340311282964;12334.629961101182;12422;12469.127161098999;9113.41658852194;9465.290103242422;9598.184154346958;9656.179224765974;9814.263930205407;8395.24442800151;8755.518446485505;9339.486328252011;9683.080107389787;9689.806203875742 02:21:53 INFO - PROCESS | 12629 | __end_tp_report 02:21:53 INFO - PROCESS | 12629 | __start_cc_report 02:21:53 INFO - PROCESS | 12629 | _x_x_mozilla_cycle_collect,1135 02:21:53 INFO - PROCESS | 12629 | __end_cc_report 02:21:53 INFO - PROCESS | 12629 | __startTimestamp1483957313099__endTimestamp 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | ------- Summary: start ------- 02:21:53 INFO - PROCESS | 12629 | Number of tests: 6 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | [#0] dojo.html Cycles:165 Average:4789.24 Median:4924.76 stddev:507.22 (10.3%) stddev-sans-first:478.84 02:21:53 INFO - PROCESS | 12629 | Values: 2600.5 2605.5 2611.4 2636.4 2641.0 4732.0 4767.0 4827.1 4859.2 4868.5 4813.0 4815.3 4851.3 4863.6 4904.2 4373.8 4410.6 4439.1 4506.1 4543.2 4102.1 4445.8 4494.8 4540.0 4580.9 4378.8 4498.8 4524.9 4539.8 4614.7 4353.8 4367.0 4385.9 4426.0 4461.2 4402.6 4405.4 4410.2 4449.2 4471.5 4757.3 4811.7 4822.4 4829.6 4875.8 5061.3 5087.5 5142.4 5159.3 5184.9 5229.5 5231.9 5241.6 5255.8 5272.3 4875.6 4880.1 4892.5 4895.2 4927.1 5260.8 5284.2 5305.4 5340.8 5360.0 5055.7 5111.8 5130.8 5167.9 5181.7 5053.8 5090.5 5196.2 5213.2 5217.8 5089.1 5096.6 5138.1 5138.4 5175.8 5061.5 5124.6 5129.7 5135.4 5142.7 4401.8 4424.4 4453.5 4453.6 4455.0 3824.8 3863.2 3886.1 3895.6 3912.4 4523.0 4527.2 4528.2 4578.3 4585.7 5072.9 5283.7 5284.6 5296.1 5296.6 4420.0 4459.1 4502.4 4503.8 4562.0 4721.2 4721.9 4727.6 4732.8 4771.8 4912.2 4914.6 4924.8 4926.0 4979.9 5101.9 5113.8 5118.1 5126.7 5150.9 4829.5 4829.8 4832.1 4867.2 4879.5 5015.0 5047.7 5053.2 5058.3 5067.2 5055.0 5071.6 5075.4 5134.8 5172.8 5064.6 5083.0 5088.5 5137.0 5140.6 4941.0 5074.4 5080.8 5087.4 5129.5 4912.7 4944.0 4996.3 5000.9 5002.4 5072.4 5093.9 5103.4 5141.9 5156.9 4957.8 4967.6 4971.0 4971.4 5019.2 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | [#1] ext.html Cycles:180 Average:45930.72 Median:19175.13 stddev:80143.50 (418.0%) stddev-sans-first:80295.80 02:21:53 INFO - PROCESS | 12629 | Values: 519.9 527.6 535.3 537.3 538.9 29615.1 31997.7 34091.7 34985.0 35281.1 40859.8 41222.4 41249.6 41305.8 41316.2 7597.8 7776.7 7777.1 7782.1 7787.1 7434.3 7602.8 7785.1 7789.2 7977.6 10002.1 10229.3 10231.7 10552.1 10555.3 9702.2 9774.9 9777.0 9785.8 9799.6 9978.5 10063.0 10063.2 10068.9 10070.5 38787.4 38941.2 39308.0 39320.6 39327.2 3650.8 3761.6 3782.0 3817.5 3840.7 28979.6 29086.7 29128.9 29367.4 29970.6 3429.4 3432.2 3448.9 3489.1 3530.7 246474.0 246513.0 247509.0 247996.0 248525.0 54060.0 54448.0 54469.5 54516.5 54570.2 57474.0 57545.8 57546.4 57554.4 57638.7 14069.0 14577.5 14589.9 14629.7 14677.6 11032.6 11079.5 11116.8 11121.7 11122.9 12985.5 13445.0 14503.2 14711.9 16477.5 5747.8 5819.4 5850.6 5937.5 5968.0 782.0 782.3 787.8 802.9 804.5 26281.0 26947.7 27045.6 27124.6 27390.9 975.2 975.3 979.8 992.9 1019.0 13568.2 14333.3 14503.5 14681.3 14780.6 343923.0 347107.0 347709.0 347892.0 348514.0 45252.8 46014.0 46071.5 49908.0 50938.0 1185.9 1237.7 1253.8 1258.7 1259.7 27688.0 28719.9 29001.4 29808.3 29858.7 43340.3 43925.1 43959.3 43972.3 43979.8 312532.0 312702.0 313430.0 314018.0 314319.9 24623.5 24789.5 25133.5 25157.0 25171.9 36940.4 37422.8 41399.8 41915.4 41942.2 33545.9 36014.6 36405.3 36816.4 37162.0 34861.1 35325.8 35363.3 35599.3 35821.6 34252.5 34365.1 34606.0 35043.8 35179.5 29828.4 30849.0 31911.8 32214.4 32313.7 24003.3 24254.8 24369.8 24646.0 24689.4 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | [#2] jquery.html Cycles:180 Average:29611.89 Median:5105.99 stddev:92732.49 (1816.2%) stddev-sans-first:92966.63 02:21:53 INFO - PROCESS | 12629 | Values: 366.5 368.6 372.4 381.8 392.8 17084.1 17741.0 17752.6 17922.6 18136.2 17083.6 17100.9 17468.6 17557.9 17608.0 5057.3 5200.2 5229.6 5236.0 5247.2 5032.9 5079.8 5105.0 5128.2 5130.1 5107.0 5110.8 5114.0 5119.4 5121.7 5085.3 5099.7 5279.6 5389.5 5462.0 5417.2 5433.1 5455.6 5485.1 5496.2 12099.8 12439.4 12492.5 12541.6 12544.1 2406.1 2455.7 2471.9 2505.3 2544.9 8650.8 8693.6 8951.6 9160.0 9294.6 1685.1 1692.6 1703.3 1725.5 1729.9 77915.1 78240.2 78837.4 82614.0 82778.0 9663.8 9829.7 10036.3 10047.3 10147.6 13554.3 13567.5 13573.3 13579.4 13606.0 7163.7 7230.7 7237.4 7450.3 7490.4 6675.6 6720.9 6959.9 6989.3 7098.4 4288.7 4407.6 4430.6 4504.5 4546.1 1721.7 1780.8 1786.3 1792.2 1856.1 877.5 891.7 895.3 915.1 937.3 17225.0 17975.2 18174.5 18301.5 18437.2 852.8 854.4 866.5 872.0 886.0 8920.6 9839.1 9915.5 9964.4 9985.5 533934.0 548627.0 574231.0 574309.0 588932.0 73106.0 77153.0 84362.6 95373.0 98030.5 988.8 1010.0 1024.8 1033.3 1033.9 15742.2 16049.8 16080.7 17110.6 17155.5 31094.8 34295.1 38723.0 38738.8 39554.2 50886.7 52216.2 55427.0 56293.4 57086.4 7645.6 7743.7 7820.6 7839.1 7999.4 11911.8 12188.8 12532.9 12813.5 13172.1 7243.5 7314.2 9850.1 10425.9 10673.6 7173.1 7541.9 7725.7 7887.7 8066.2 6909.0 6921.0 7004.4 7386.2 7544.9 12234.4 12314.8 12343.1 12535.7 12592.4 10321.3 10706.6 10821.9 10930.1 10945.5 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | [#3] mootools.html Cycles:180 Average:4679.00 Median:5132.33 stddev:2526.07 (49.2%) stddev-sans-first:2519.92 02:21:53 INFO - PROCESS | 12629 | Values: 1239.2 1338.9 1348.6 1355.0 1363.5 6427.6 6817.9 7043.9 7065.0 7180.6 7133.0 7170.5 7193.9 7194.4 7202.2 1842.2 1903.8 2065.6 2094.9 2098.5 2057.7 2129.9 2131.8 2145.8 2147.1 2016.5 2032.6 2039.3 2039.4 2039.7 2028.2 2033.1 2034.9 2036.6 2055.3 2002.8 2039.3 2055.1 2057.2 2059.5 7038.1 7152.9 7154.9 7165.9 7234.9 4325.2 4377.6 4378.2 4380.6 4380.6 2634.2 2716.9 2754.9 2804.6 2806.9 935.7 958.8 976.7 981.9 1004.3 9216.7 9314.5 9331.2 9343.9 9359.0 3812.0 3868.8 3989.9 4046.3 4064.7 8275.8 8280.5 8302.3 8303.6 8420.2 4442.8 4450.4 4451.3 4458.2 4506.5 3621.4 3691.2 3964.8 4100.9 4111.3 3336.1 3362.8 3498.8 3507.8 3509.7 1047.2 1049.3 1059.8 1071.9 1080.9 837.9 838.3 850.8 861.9 872.5 4593.4 4890.8 4913.5 4914.2 5058.5 863.7 916.4 918.4 919.5 933.6 3223.0 3237.4 3300.2 3376.1 3406.7 8475.3 8487.4 8523.5 8622.1 8667.0 8504.6 8562.1 8613.8 8622.1 8630.5 6764.8 6814.0 6814.0 6814.4 6817.9 4731.6 4777.4 4836.1 4862.1 4877.4 7686.2 7792.4 7849.0 7869.7 7917.2 7682.7 8051.2 8054.6 8068.4 8071.1 5593.6 5746.6 6167.1 6257.8 6313.3 6502.2 6661.9 6690.6 6881.7 6882.1 5879.2 5999.4 6065.2 6145.6 6158.8 6034.2 6042.8 6050.1 6066.4 6088.0 5206.2 5235.4 5240.3 5246.1 5264.1 4160.4 4179.9 4292.2 4293.7 4351.9 4206.7 4225.5 4238.1 4241.5 4346.5 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | [#4] prototype.html Cycles:180 Average:4225.66 Median:4780.66 stddev:1196.11 (25.0%) stddev-sans-first:1163.35 02:21:53 INFO - PROCESS | 12629 | Values: 338.9 347.5 354.4 356.9 359.5 4654.3 4787.8 4886.0 4909.1 4916.4 4694.6 4778.3 4812.8 4832.9 4833.5 3886.6 3900.6 3918.8 3920.8 3926.6 3687.9 3819.6 3881.2 3912.6 3913.6 3757.8 3815.5 3842.9 3845.6 3868.4 3821.1 3827.8 3829.1 3835.0 3849.8 3471.7 3479.8 3483.3 3485.7 3486.9 4580.0 4681.9 4689.9 4705.4 4763.1 4398.6 4399.2 4407.7 4409.4 4414.4 5041.5 5047.9 5057.3 5087.4 5091.3 3713.6 3776.4 3813.9 3816.7 3831.9 5266.7 5270.2 5275.6 5279.5 5292.7 3882.1 3885.8 3886.4 3890.8 3895.8 3835.7 3957.6 3967.6 3981.5 3991.2 4384.8 4388.1 4402.5 4406.3 4411.8 5055.4 5055.4 5061.9 5086.8 5089.0 1222.1 1251.9 1311.8 1322.2 1324.6 902.4 914.5 919.5 926.0 926.3 4363.8 4365.5 4389.6 4392.6 4415.3 4827.3 5074.4 5079.5 5112.9 5119.4 4310.4 4343.3 4375.8 4379.4 4379.7 2662.2 2682.7 2683.5 2685.3 2685.6 4735.9 4752.8 4770.0 4783.0 4803.4 5043.6 5328.7 5352.5 5363.7 5365.2 4914.5 4917.9 4928.8 4931.2 4938.2 4946.9 5210.4 5213.4 5215.4 5228.6 5124.4 5138.9 5144.5 5168.9 5170.7 4890.4 4903.0 4909.2 4917.4 4935.7 3558.9 3633.3 3641.0 3660.2 3685.9 5184.6 5192.3 5196.6 5204.7 5222.3 5037.2 5049.3 5059.9 5068.3 5084.3 4814.7 5054.2 5070.8 5078.7 5093.7 4822.6 4864.9 4905.0 5001.6 5003.4 5013.0 5047.0 5067.9 5081.8 5101.3 4932.1 4946.7 4956.4 4956.4 4971.0 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - PROCESS | 12629 | [#5] yui.html Cycles:180 Average:14740.84 Median:45716.43 stddev:17916.83 (39.2%) stddev-sans-first:17935.78 02:21:53 INFO - PROCESS | 12629 | Values: 636.5 645.0 719.0 747.6 760.9 13096.2 13756.2 13811.7 13831.5 13844.2 13455.3 13555.1 13575.2 13612.0 13663.0 660.1 678.2 773.2 792.4 793.3 790.4 792.1 792.6 792.7 793.1 838.9 839.0 839.1 839.9 840.0 688.1 699.8 708.1 709.3 830.8 522.7 592.1 607.3 612.4 614.5 12629.2 12682.7 12685.9 12702.2 12708.7 12383.4 12633.7 12711.9 12961.9 13047.6 11705.4 11751.3 11831.8 12110.1 12138.0 3998.6 4004.5 4026.5 4208.2 4216.3 57953.7 59339.4 59731.0 60161.0 60965.4 10113.3 10155.5 10265.6 10289.3 10409.7 19093.3 19183.5 19214.1 19348.9 19416.5 6856.2 6931.0 6942.3 7037.5 7193.9 3652.6 3657.2 3669.1 3680.9 3737.3 2617.2 2682.7 3207.2 3353.3 3441.9 529.1 538.1 539.8 542.8 550.1 636.3 653.2 660.6 668.7 669.4 8754.3 8877.4 8998.1 9060.0 9061.6 631.5 653.2 654.5 660.9 666.3 3957.8 4189.8 4301.4 4379.3 4385.3 68527.3 68741.3 69090.0 69761.0 70965.3 48286.3 57518.7 57936.7 57939.7 58722.7 40324.0 46551.3 47322.5 48960.0 50005.5 9287.6 9829.5 9839.9 9858.1 9985.1 32058.2 34387.8 34990.1 35221.5 35653.3 42093.4 42273.0 42466.8 44458.6 44881.6 10634.1 10712.2 10882.4 10901.2 11039.2 12767.9 12957.7 13082.7 13603.6 14042.0 11729.4 12396.0 13008.3 13144.3 13283.8 11832.1 12329.1 12450.3 12548.7 12607.8 11923.1 11994.3 12334.6 12422.0 12469.1 9113.4 9465.3 9598.2 9656.2 9814.3 8395.2 8755.5 9339.5 9683.1 9689.8 02:21:53 INFO - PROCESS | 12629 | -------- Summary: end -------- 02:21:53 INFO - PROCESS | 12629 | 02:21:53 INFO - TEST-INFO | 12629: exit 0 02:21:53 INFO - TEST-OK | dromaeo_css | took 1121395ms 02:21:53 INFO - TEST-START | kraken 02:21:53 INFO - operating with platform_type : linux_ 02:21:53 INFO - Initialising browser for kraken test... 02:21:53 INFO - TEST-INFO | started process 12929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzes3nJ/profile http://localhost:55518/getInfo.html) 02:21:54 INFO - PROCESS | 12929 | 1483957314374 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 02:21:58 INFO - PROCESS | 12929 | __metrics Screen width/height:1600/1200 02:21:58 INFO - PROCESS | 12929 | colorDepth:24 02:21:58 INFO - PROCESS | 12929 | Browser inner width/height: 1024/697 02:21:58 INFO - PROCESS | 12929 | __metrics 02:21:58 INFO - PROCESS | 12929 | 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" 02:21:58 INFO - PROCESS | 12929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:59 INFO - PROCESS | 12929 | console.error: PushService: 02:21:59 INFO - PROCESS | 12929 | stateChangeProcessEnqueue: Error transitioning state 02:21:59 INFO - PROCESS | 12929 | UnknownError 02:21:59 INFO - TEST-INFO | 12929: exit 0 02:21:59 INFO - Browser initialized. 02:21:59 INFO - Running cycle 1/1 for kraken test... 02:21:59 INFO - TEST-INFO | started process 13013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzes3nJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:11 INFO - PROCESS | 13013 | RSS: Main: 152002560 02:22:11 INFO - PROCESS | 13013 | 02:22:14 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:15 INFO - PROCESS | 13013 | RSS: Main: 206606336 02:22:15 INFO - PROCESS | 13013 | 02:22:18 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-dft) 02:22:18 INFO - PROCESS | 13013 | RSS: Main: 185753600 02:22:18 INFO - PROCESS | 13013 | 02:22:22 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-fft) 02:22:22 INFO - PROCESS | 13013 | RSS: Main: 267993088 02:22:22 INFO - PROCESS | 13013 | 02:22:24 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-oscillator) 02:22:25 INFO - PROCESS | 13013 | RSS: Main: 179515392 02:22:25 INFO - PROCESS | 13013 | 02:22:27 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:28 INFO - PROCESS | 13013 | RSS: Main: 182648832 02:22:28 INFO - PROCESS | 13013 | 02:22:31 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:32 INFO - PROCESS | 13013 | RSS: Main: 222236672 02:22:32 INFO - PROCESS | 13013 | 02:22:35 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:36 INFO - PROCESS | 13013 | RSS: Main: 222101504 02:22:36 INFO - PROCESS | 13013 | 02:22:38 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55518/tests/kraken/driver.html?testName=json-parse-financial) 02:22:39 INFO - PROCESS | 13013 | RSS: Main: 220053504 02:22:39 INFO - PROCESS | 13013 | 02:22:41 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:41 INFO - PROCESS | 13013 | RSS: Main: 183304192 02:22:41 INFO - PROCESS | 13013 | 02:22:43 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:44 INFO - PROCESS | 13013 | RSS: Main: 191881216 02:22:44 INFO - PROCESS | 13013 | 02:22:46 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:47 INFO - PROCESS | 13013 | RSS: Main: 198717440 02:22:47 INFO - PROCESS | 13013 | 02:22:49 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:50 INFO - PROCESS | 13013 | RSS: Main: 203497472 02:22:50 INFO - PROCESS | 13013 | 02:22:53 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:54 INFO - PROCESS | 13013 | RSS: Main: 204681216 02:22:54 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55518/tests/kraken/driver.html?testName=ai-astar) 02:22:56 INFO - PROCESS | 13013 | RSS: Main: 255160320 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | __start_tp_report 02:22:56 INFO - PROCESS | 13013 | _x_x_mozilla_page_load 02:22:56 INFO - PROCESS | 13013 | _x_x_mozilla_page_load_details 02:22:56 INFO - PROCESS | 13013 | |i|pagename|runs| 02:22:56 INFO - PROCESS | 13013 | |0;ai-astar;105;114;115;115;114;116;114;114;115;113 02:22:56 INFO - PROCESS | 13013 | |1;audio-beat-detection;152;129;123;158;125;125;131;123;146;126 02:22:56 INFO - PROCESS | 13013 | |2;audio-dft;163;161;162;162;164;162;162;161;160;161 02:22:56 INFO - PROCESS | 13013 | |3;audio-fft;76;76;76;110;77;77;78;76;92;76 02:22:56 INFO - PROCESS | 13013 | |4;audio-oscillator;86;85;106;86;85;84;102;84;84;107 02:22:56 INFO - PROCESS | 13013 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;116;117 02:22:56 INFO - PROCESS | 13013 | |6;imaging-darkroom;149;149;149;149;148;149;149;149;149;149 02:22:56 INFO - PROCESS | 13013 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 02:22:56 INFO - PROCESS | 13013 | |8;json-parse-financial;61;60;61;60;61;62;62;62;63;62 02:22:56 INFO - PROCESS | 13013 | |9;json-stringify-tinderbox;67;68;67;67;68;66;67;67;68;68 02:22:56 INFO - PROCESS | 13013 | |10;stanford-crypto-aes;85;84;87;85;87;87;86;86;85;84 02:22:56 INFO - PROCESS | 13013 | |11;stanford-crypto-ccm;145;139;134;137;133;131;130;138;217;138 02:22:56 INFO - PROCESS | 13013 | |12;stanford-crypto-pbkdf2;179;177;178;183;178;177;179;177;178;180 02:22:56 INFO - PROCESS | 13013 | |13;stanford-crypto-sha256-iterative;69;70;69;69;69;69;68;69;69;67 02:22:56 INFO - PROCESS | 13013 | __end_tp_report 02:22:56 INFO - PROCESS | 13013 | __start_cc_report 02:22:56 INFO - PROCESS | 13013 | _x_x_mozilla_cycle_collect,1849 02:22:56 INFO - PROCESS | 13013 | __end_cc_report 02:22:56 INFO - PROCESS | 13013 | __startTimestamp1483957376405__endTimestamp 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | ------- Summary: start ------- 02:22:56 INFO - PROCESS | 13013 | Number of tests: 14 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:3.10 (2.7%) stddev-sans-first:0.88 02:22:56 INFO - PROCESS | 13013 | Values: 105.0 114.0 115.0 115.0 114.0 116.0 114.0 114.0 115.0 113.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:130.00 stddev:13.10 (10.1%) stddev-sans-first:12.13 02:22:56 INFO - PROCESS | 13013 | Values: 152.0 129.0 123.0 158.0 125.0 125.0 131.0 123.0 146.0 126.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 02:22:56 INFO - PROCESS | 13013 | Values: 163.0 161.0 162.0 162.0 164.0 162.0 162.0 161.0 160.0 161.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:11.19 (14.6%) stddev-sans-first:11.69 02:22:56 INFO - PROCESS | 13013 | Values: 76.0 76.0 76.0 110.0 77.0 77.0 78.0 76.0 92.0 76.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.50 stddev:9.84 (11.6%) stddev-sans-first:10.27 02:22:56 INFO - PROCESS | 13013 | Values: 86.0 85.0 106.0 86.0 85.0 84.0 102.0 84.0 84.0 107.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 02:22:56 INFO - PROCESS | 13013 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:22:56 INFO - PROCESS | 13013 | Values: 149.0 149.0 149.0 149.0 148.0 149.0 149.0 149.0 149.0 149.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:22:56 INFO - PROCESS | 13013 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 02:22:56 INFO - PROCESS | 13013 | Values: 61.0 60.0 61.0 60.0 61.0 62.0 62.0 62.0 63.0 62.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 02:22:56 INFO - PROCESS | 13013 | Values: 67.0 68.0 67.0 67.0 68.0 66.0 67.0 67.0 68.0 68.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.22 02:22:56 INFO - PROCESS | 13013 | Values: 85.0 84.0 87.0 85.0 87.0 87.0 86.0 86.0 85.0 84.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:138.00 stddev:25.95 (18.8%) stddev-sans-first:27.52 02:22:56 INFO - PROCESS | 13013 | Values: 145.0 139.0 134.0 137.0 133.0 131.0 130.0 138.0 217.0 138.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:178.50 stddev:1.84 (1.0%) stddev-sans-first:1.94 02:22:56 INFO - PROCESS | 13013 | Values: 179.0 177.0 178.0 183.0 178.0 177.0 179.0 177.0 178.0 180.0 02:22:56 INFO - PROCESS | 13013 | 02:22:56 INFO - PROCESS | 13013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 02:22:56 INFO - PROCESS | 13013 | Values: 69.0 70.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 67.0 02:22:56 INFO - PROCESS | 13013 | -------- Summary: end -------- 02:22:56 INFO - PROCESS | 13013 | 02:22:57 INFO - TEST-INFO | 13013: exit 0 02:22:57 INFO - TEST-OK | kraken | took 63718ms 02:22:57 INFO - SUITE-END | took 1185s 02:22:58 INFO - Completed test suite (00:19:45) 02:22:58 INFO - javascript benchmark 02:22:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.5319042572337, 2605.531004419204, 2611.38632421381, 2636.446346267284, 2641.0492222799776, 4731.952680473194, 4767.046590681869, 4827.106985207739, 4859.198232291672, 4868.51314868513, 4813.037392521501, 4815.277708343741, 4851.345068415762, 4863.562279394854, 4904.190808516591, 4373.759443230637, 4410.647148228134, 4439.112177564484, 4506.121306345264, 4543.204939135655, 4102.118044620406, 4445.755483448425, 4494.786407669943, 4540.02389486262, 4580.862574122782, 4378.8029538670835, 4498.797554110073, 4524.864254072383, 4539.841105561306, 4614.653900957424, 4353.84761533348, 4366.956330436687, 4385.912281754379, 4425.955740442619, 4461.219286624828, 4402.647788176938, 4405.449318835145, 4410.16206920684, 4449.243628583149, 4471.508134105278, 4757.286407038937, 4811.735354555498, 4822.445418776815, 4829.637777166727, 4875.804967801284, 5061.316722242524, 5087.49125087492, 5142.357205349332, 5159.251908473288, 5184.948150518484, 5229.477052294778, 5231.9476805232225, 5241.554467870235, 5255.842324730226, 5272.261883336336, 4875.585575226146, 4880.072786170652, 4892.51074892515, 4895.167821470359, 4927.113119638428, 5260.763265653055, 5284.180951952453, 5305.4164041955355, 5340.786368545292, 5360.0351936650995, 5055.747212639353, 5111.846644600668, 5130.7947682093045, 5167.896642067138, 5181.663191892515, 5053.84838454847, 5090.541851233407, 5196.194589838506, 5213.191955246867, 5217.791288348423, 5089.109405853961, 5096.566791822663, 5138.126518491866, 5138.409082955508, 5175.844724658266, 5061.544460998528, 5124.641275110781, 5129.717865517432, 5135.35808023997, 5142.717150556755, 4401.823927042947, 4424.358468022118, 4453.465584129925, 4453.643708503312, 4455.04216593434, 3824.7513911595656, 3863.2466668999277, 3886.1256217351433, 3895.6493915547735, 3912.39357899526, 4523.0, 4527.230370836965, 4528.184926713223, 4578.313253012075, 4585.72485650862, 5072.923906141411, 5283.709395983258, 5284.603654725911, 5296.09966305729, 5296.602754793406, 4419.977900110479, 4459.130469558405, 4502.369668246448, 4503.797329120198, 4562.0, 4721.173794585934, 4721.905561888743, 4727.64542659302, 4732.810687572527, 4771.761411929389, 4912.23860301661, 4914.5576898078625, 4924.76196155612, 4926.0, 4979.850604481871, 5101.92347114801, 5113.821016264413, 5118.104331741856, 5126.7180305083575, 5150.948490515047, 4829.492903245108, 4829.806807727651, 4832.057748738962, 4867.245576935581, 4879.512048795092, 5014.974925125351, 5047.697138171721, 5053.242013697828, 5058.342415485963, 5067.189249720027, 5055.0, 5071.594272458268, 5075.441701412916, 5134.7946082156295, 5172.818951336685, 5064.5948324134715, 5083.034223497523, 5088.465711100281, 5137.049645815536, 5140.56305214061, 4940.9505904941925, 5074.3657042869645, 5080.771365288645, 5087.389513258433, 5129.538341549279, 4912.729799861042, 4944.035912996931, 4996.325496057985, 5000.924986125138, 5002.424721156968, 5072.416672082758, 5093.8726531837, 5103.387593488656, 5141.922871156861, 5156.948430515797, 4957.752112394293, 4967.627427942846, 4971.030649023406, 4971.37857767779, 5019.196928491424], "value": 4755.7766578616975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.8960207958409, 527.6491133396291, 535.2880668710612, 537.3363895588949, 538.8922215556889, 29615.111546653607, 31997.680023199762, 34091.659083409155, 34985.0, 35281.11797205071, 40859.795701021525, 41222.38166427506, 41249.58750412495, 41305.79347103268, 41316.17367652645, 7597.81005474862, 7776.688932442696, 7777.066751989769, 7782.105057918356, 7787.104482984472, 7434.256574342549, 7602.771916842504, 7785.065792104955, 7789.221077892222, 7977.60111994398, 10002.149817265541, 10229.335093218917, 10231.693049208536, 10552.103071238915, 10555.261131720783, 9702.175315098226, 9774.902250977542, 9777.0, 9785.804283914282, 9799.608015679365, 9978.451185184811, 10063.0, 10063.24525660571, 10068.949655251678, 10070.496475176285, 38787.41818872719, 38941.22117557661, 39308.0, 39320.606793931984, 39327.21345573101, 3650.7992060436663, 3761.6238376162437, 3782.014442417725, 3817.541894972593, 3840.7311488195837, 28979.56530652042, 29086.70913290861, 29128.854355728297, 29367.412651747058, 29970.55044174339, 3429.4341433663417, 3432.1934345428804, 3448.9482657760154, 3489.1277180704824, 3530.6645868642436, 246474.0, 246513.0, 247509.0, 247996.0, 248524.9999999982, 54060.0, 54448.0, 54469.45530544644, 54516.45483545193, 54570.177368074124, 57474.0, 57545.83497907571, 57546.424535754944, 57554.42445575575, 57638.71180644154, 14069.01516893828, 14577.489787857374, 14589.85410145885, 14629.707405851823, 14677.55967320982, 11032.613858514913, 11079.50142243585, 11116.833247501294, 11121.666350009513, 11122.888771112348, 12985.506666733258, 13445.0, 14503.187101612299, 14711.926440367944, 16477.505674829776, 5747.770089196469, 5819.388964158787, 5850.64896106235, 5937.52499800015, 5968.0, 781.9804504887423, 782.2529484342439, 787.7794217619075, 802.8880001198382, 804.5333706450361, 26281.00660874466, 26947.73052269452, 27045.594316085273, 27124.59313110305, 27390.863045684644, 975.2295686407658, 975.2782940623887, 979.7648564344648, 992.8709267795285, 1019.0421004255976, 13568.1859088455, 14333.283335833166, 14503.492377766728, 14681.339339729739, 14780.556583302303, 343923.0, 347107.0, 347709.0, 347892.0, 348514.0, 45252.77373613111, 46014.0, 46071.539284607396, 49908.0, 50938.0, 1185.916985810985, 1237.6843904804218, 1253.7931241345075, 1258.6916205529521, 1259.7291582309665, 27688.0, 28719.85640071786, 29001.41997160003, 29808.254793629465, 29858.701412985592, 43340.34989475097, 43925.12149757051, 43959.340609891515, 43972.34041489444, 43979.78010110057, 312532.0, 312702.0, 313430.0, 314018.0, 314319.85441164195, 24623.507529848943, 24789.50420991606, 25133.497330053662, 25157.0, 25171.87414062918, 36940.44589331109, 37422.84485748019, 41399.7930010348, 41915.371269430376, 41942.16115677731, 33545.859732576384, 36014.639853601126, 36405.27189456249, 36816.44775328319, 37162.0, 34861.12847178841, 35325.82337088298, 35363.29273414569, 35599.28801424009, 35821.641783582876, 34252.48621270733, 34365.14087147841, 34606.0, 35043.82478087695, 35179.472307915916, 29828.403431931674, 30849.0, 31911.84044079765, 32214.355712885143, 32313.676863231067, 24003.27990160298, 24254.757452425954, 24369.756302437458, 24646.0, 24689.382765431008], "value": 17519.79849609154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.50704802041247, 368.6276860371025, 372.3762697481718, 381.80146323911583, 392.75256588349356, 17084.145792710362, 17741.0, 17752.55618609532, 17922.64154716905, 18136.18387172577, 17083.572910677238, 17100.914495427536, 17468.56328591786, 17557.91221043893, 17607.950171460572, 5057.342545469093, 5200.193969934648, 5229.607779416559, 5235.973820130913, 5247.239150323201, 5032.899342013157, 5079.847604571869, 5104.974475127619, 5128.230765385185, 5130.07658621448, 5107.0, 5110.821121260757, 5113.974430127844, 5119.411267704206, 5121.66709163905, 5085.262636917645, 5099.745012749367, 5279.551238144743, 5389.51494365509, 5461.972690136564, 5417.187421886709, 5433.130699088167, 5455.645383050129, 5485.122380419154, 5496.1755736639425, 12099.818502722379, 12439.440225189797, 12492.500299987989, 12541.623751287385, 12544.059195560278, 2406.1458182345364, 2455.742147074567, 2471.913483028103, 2505.2985164154065, 2544.8982040718347, 8650.783730406727, 8693.565321733888, 8951.641934322619, 9159.954200228956, 9294.628214871396, 1685.0647890420812, 1692.627621923175, 1703.2590822992038, 1725.5082301544, 1729.9135043247786, 77915.05212369736, 78240.21759782387, 78837.41507821072, 82614.0, 82778.0, 9663.758406039764, 9829.705108846745, 10036.347637403545, 10047.346922450017, 10147.644832430977, 13554.322283885964, 13567.52513662017, 13573.253471059186, 13579.388927498287, 13606.047576669736, 7163.7492687755675, 7230.710771569184, 7237.384822290059, 7450.292222238879, 7490.363319117827, 6675.566088204251, 6720.899186512206, 6959.930400696029, 6989.30106989297, 7098.36114749675, 4288.699791014661, 4407.625351845065, 4430.601245887886, 4504.527024662429, 4546.090781843578, 1721.7159168737269, 1780.7740324594258, 1786.330126202674, 1792.1755992243454, 1856.1183437866905, 877.5305211711831, 891.6789955615973, 895.3329769321897, 915.0986278515657, 937.3438592984937, 17224.990379473606, 17975.191116399794, 18174.5456363592, 18301.450956471326, 18437.1703273353, 852.8336974289954, 854.4104567848165, 866.4714524140269, 871.9694810681596, 886.0386480668418, 8920.643174273086, 9839.114479696718, 9915.504224788732, 9964.402135871871, 9985.45080020606, 533934.0, 548627.0, 574231.0, 574309.0, 588932.0, 73106.0, 77153.0, 84362.57818710867, 95373.04626953781, 98030.5098474503, 988.8170688422665, 1009.9596016159271, 1024.7847951930178, 1033.3334998925802, 1033.9017793309624, 15742.212889355715, 16049.839501605302, 16080.67838643244, 17110.572235693708, 17155.485335439957, 31094.844525777225, 34295.142621434665, 38723.0, 38738.80630596829, 39554.2089158221, 50886.74556627193, 52216.21675674944, 55427.0, 56293.43706563046, 57086.42913570811, 7645.5794931279315, 7743.651535680795, 7820.569868657279, 7839.059312882263, 7999.400044996532, 11911.82132268034, 12188.817167742669, 12532.874671253536, 12813.487460501476, 13172.07795454309, 7243.45674074436, 7314.232005639331, 9850.064243896819, 10425.895741042492, 10673.626423075155, 7173.1392232932385, 7541.924580754122, 7725.652345644572, 7887.698529742528, 8066.193380661887, 6909.0, 6920.9653951729915, 7004.4396448283, 7386.2244464332625, 7544.886826697494, 12234.449449774604, 12314.79815248024, 12343.13598048128, 12535.686607834878, 12592.433340499516, 10321.329113607591, 10706.571737130427, 10821.9458902705, 10930.125589952944, 10945.45272736376], "value": 8317.641902152925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.1945235596866, 1338.8527262001178, 1348.554976857637, 1354.9661258468543, 1363.5023216525965, 6427.614343139409, 6817.931820681792, 7043.894341584881, 7065.046218760473, 7180.569165850053, 7132.964335178317, 7170.498065135443, 7193.8561228775525, 7194.424446044317, 7202.171750248723, 1842.1710230396309, 1903.828655421012, 2065.5765568058514, 2094.937151885438, 2098.5278312379746, 2057.6913462980524, 2129.9041543130597, 2131.7761635028332, 2145.8068773810355, 2147.119680930811, 2016.5059560407647, 2032.634125857345, 2039.2862498125612, 2039.377989713137, 2039.6634555298358, 2028.2292728762975, 2033.1054336092072, 2034.9287774927807, 2036.6232247034345, 2055.321743824542, 2002.8297594704322, 2039.2862498125685, 2055.126571207246, 2057.1565658080117, 2059.4748339173566, 7038.085048943656, 7152.856942861114, 7154.856902861914, 7165.89251161233, 7234.927650723531, 4325.178216138955, 4377.562243775629, 4378.211921854065, 4380.649548036149, 4380.649548036149, 2634.2492389669046, 2716.9456610867674, 2754.9173524794287, 2804.551271796523, 2806.9438611227865, 935.714607044851, 958.8417911044669, 976.6532880827275, 981.8870829854516, 1004.2869562610555, 9216.677416290464, 9314.487703176323, 9331.16019558243, 9343.906560934372, 9359.0, 3811.961880381161, 3868.7678739275734, 3989.940150897739, 4046.291898917678, 4064.6748260139116, 8275.751727448187, 8280.544570048705, 8302.335813134934, 8303.584820758937, 8420.242178203991, 4442.822287108479, 4450.418757120862, 4451.287793952952, 4458.152950939311, 4506.549345065533, 3621.3843646580144, 3691.206390626028, 3964.801759911993, 4100.856470023595, 4111.259973204792, 3336.115929278743, 3362.81504517249, 3498.8250587470525, 3507.8421471033867, 3509.701675357623, 1047.1570385839473, 1049.2969710294121, 1059.8304271316551, 1071.8874518175635, 1080.9243352965218, 837.8910741603675, 838.2748922182268, 850.8213275212274, 861.9396642234983, 872.4547158026234, 4593.425821772278, 4890.755462226874, 4913.533214344703, 4914.164592019365, 5058.468860769566, 863.7365603490996, 916.3860213656866, 918.4397517514311, 919.5494207838245, 933.5658918602746, 3222.9838850805595, 3237.4496335623003, 3300.174956260935, 3376.122208225879, 3406.710429613461, 8475.27960123384, 8487.448315859448, 8523.48859068458, 8622.051574326819, 8667.0, 8504.617292221865, 8562.100979397073, 8613.827723445496, 8622.137786221328, 8630.482171069756, 6764.763233286812, 6813.965930170318, 6814.0, 6814.420774234147, 6817.897731534031, 4731.621470282438, 4777.378940737682, 4836.081144582518, 4862.07620552094, 4877.439094504036, 7686.192949740421, 7792.415568832247, 7849.0, 7869.724559640385, 7917.168697286702, 7682.7311044113185, 8051.2351326623875, 8054.597270136587, 8068.354531637572, 8071.112177660335, 5593.580481463825, 5746.626469279484, 6167.074938759042, 6257.812265632038, 6313.273973493107, 6502.219733631805, 6661.933380666132, 6690.632015239208, 6881.724731010703, 6882.139732533434, 5879.18713934045, 5999.350178700718, 6065.181200538047, 6145.600535965148, 6158.753649853956, 6034.24571928509, 6042.818715438544, 6050.092486127116, 6066.423689749467, 6087.969560152171, 5206.193040078794, 5235.3717553893775, 5240.292560504436, 5246.134387826119, 5264.078786212474, 4160.375943608483, 4179.853705120307, 4292.227399068198, 4293.720908140961, 4351.934720979125, 4206.72656277341, 4225.471816022997, 4238.131183107517, 4241.533431322614, 4346.543612920725], "value": 3833.1574684607726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.93390788796177, 347.48225144534644, 354.35861091424516, 356.87687747727057, 359.48593511278875, 4654.348391225231, 4787.80848766049, 4885.951140488594, 4909.140900342439, 4916.410030796305, 4694.577488026077, 4778.327585345128, 4812.8074877004965, 4832.879178020543, 4833.45329494561, 3886.6113388661047, 3900.5514365847866, 3918.804059797013, 3920.843351211385, 3926.5680775114715, 3687.907802304937, 3819.598942111066, 3881.165549406877, 3912.628300311466, 3913.628205320504, 3757.755745876509, 3815.4849095372047, 3842.9423558646645, 3845.634664706862, 3868.3946162342595, 3821.14024344523, 3827.770333779982, 3829.1193025604266, 3835.0, 3849.845046486043, 3471.6701913318193, 3479.799469183153, 3483.251101013269, 3485.7037151842123, 3486.9476957845654, 4579.954200457986, 4681.852946028245, 4689.906201875943, 4705.364995602439, 4763.095011947719, 4398.626116780078, 4399.186150562156, 4407.669424793121, 4409.426774519324, 4414.381986521889, 5041.546260836506, 5047.899042019139, 5057.342545469102, 5087.440381558025, 5091.287219789232, 3713.60739722604, 3776.4146557283666, 3813.904652383713, 3816.732828701992, 3831.9233615327817, 5266.657667251617, 5270.183121616155, 5275.551578115865, 5279.52484276417, 5292.68243905363, 3882.107115363482, 3885.8445662173194, 3886.3976083706507, 3890.766554006712, 3895.7662540247675, 3835.6739677127757, 3957.604239576019, 3967.6032396760093, 3981.5023122109737, 3991.1818077294083, 4384.8246070157475, 4388.144311859221, 4402.471703395613, 4406.33904914259, 4411.823527058882, 5055.368078990126, 5055.443901170868, 5061.8734531637, 5086.77109530072, 5088.974555127201, 1222.0712258683463, 1251.8873301402734, 1311.8097875807955, 1322.2066759943957, 1324.6158614002024, 902.4314681750456, 914.4500072377257, 919.4529255093208, 925.9953700231456, 926.2775035472208, 4363.781810909441, 4365.541618130051, 4389.626881715026, 4392.582704643054, 4415.2935530315635, 4827.348307978378, 5074.3657042869645, 5079.466656001066, 5112.923306150411, 5119.389111553135, 4310.374995625617, 4343.3484977253665, 4375.759333236639, 4379.386885835986, 4379.737215767001, 2662.1614191529607, 2682.7183145769804, 2683.510651588387, 2685.3018215264174, 2685.5837345211526, 4735.881602959954, 4752.7861246244, 4770.0, 4783.0, 4803.423589169252, 5043.621728370387, 5328.6802791832615, 5352.464753524694, 5363.678179309254, 5365.248865158803, 4914.459409464956, 4917.918058027229, 4928.753562321869, 4931.18635425158, 4938.234573641092, 4946.9364086721525, 5210.400803907599, 5213.426523082382, 5215.401373052581, 5228.58171346299, 5124.410692770379, 5138.922916156186, 5144.536991670768, 5168.896622067613, 5170.663906846043, 4890.364252647133, 4902.975485122552, 4909.214525675875, 4917.434495033117, 4935.679180853233, 3558.893233203008, 3633.3459977204357, 3640.9635903640624, 3660.213054193361, 3685.9078523037138, 5184.559312458483, 5192.324997750268, 5196.610254231024, 5204.687718736888, 5222.29499017643, 5037.244413338029, 5049.31834202378, 5059.898802024012, 5068.265101560327, 5084.2881996521255, 4814.662973591955, 5054.21659642756, 5070.8225212117395, 5078.7206703631655, 5093.71984540839, 4822.638302127284, 4864.878378040577, 4904.950950490449, 5001.574866136273, 5003.374578177728, 5013.02246062029, 5046.9747651261505, 5067.945643485124, 5081.7713202905215, 5101.336826212569, 4932.087563800565, 4946.703197808143, 4956.3804524434445, 4956.430010548833, 4970.975145124251], "value": 3860.26007747764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.4685487617838, 645.0356716708521, 718.996999186135, 747.6448686873734, 760.8554374668814, 13096.214227146365, 13756.174629522237, 13811.723765524695, 13831.515896943609, 13844.238566878817, 13455.327233638303, 13555.118917270394, 13575.185488870675, 13612.0, 13663.0, 660.0660066006595, 678.2064983968768, 773.2383602151876, 792.3621484704811, 793.305857374797, 790.4348390900504, 792.0851416613821, 792.6116203060487, 792.7066985215479, 793.1473665809249, 838.9412741108125, 839.03091928822, 839.0560619303284, 839.8530257204995, 839.9958000210021, 688.1192074145127, 699.814549144472, 708.0582824842946, 709.2588245283691, 830.7923019245188, 522.7151202594595, 592.0586267834165, 607.3440684061203, 612.4182027074297, 614.5483069943588, 12629.179103358345, 12682.682932926751, 12685.873141268561, 12702.237865727993, 12708.745825083446, 12383.380830958506, 12633.684157896034, 12711.936440317832, 12961.935190324082, 13047.608571742769, 11705.361249425086, 11751.294922304689, 11831.763364732657, 12110.091743119301, 12138.0, 3998.6001399860074, 4004.4593979812644, 4026.4966879140106, 4208.242516347056, 4216.262154123016, 57953.710231449, 59339.40660593425, 59731.0, 60161.0, 60965.390346096414, 10113.29206955506, 10155.527448519922, 10265.640702575374, 10289.2797504174, 10409.739756505996, 19093.331733389543, 19183.52041198981, 19214.13536390866, 19348.903255483634, 19416.514587135436, 6856.24581296057, 6931.0, 6942.340477654615, 7037.454056654755, 7193.9280607194305, 3652.5616925969052, 3657.213699054716, 3669.082729317671, 3680.8895733127515, 3737.289914916157, 2617.175589689242, 2682.651255336833, 3207.246297120175, 3353.2790450052867, 3441.862325507002, 529.0978881007873, 538.0825692194799, 539.7544117426562, 542.7855996881289, 550.0950935710733, 636.2651137935692, 653.2063542795527, 660.5504587155963, 668.6623255256064, 669.397542212013, 8754.262547992656, 8877.422967507091, 8998.14517620825, 9060.0, 9061.637534498677, 631.5246810155959, 653.1600837791939, 654.4764188649157, 660.9471242300605, 666.3469799596422, 3957.821898014596, 4189.76651763537, 4301.440812694393, 4379.321205213197, 4385.342198670225, 68527.31472685309, 68741.3125868745, 69090.0, 69761.0, 70965.29034709587, 48286.27570586444, 57518.712406438535, 57936.71031644899, 57939.71030144822, 58722.70638646779, 40324.0, 46551.30173047407, 47322.526774731814, 48960.0, 50005.49994500008, 9287.582058807235, 9829.508524573599, 9839.868415132352, 9858.11276985046, 9985.101340879355, 32058.19854503656, 34387.82806085954, 34990.12524686903, 35221.471677925365, 35653.28693426169, 42093.36859947164, 42273.0, 42466.78766606147, 44458.55541444544, 44881.55118448904, 10634.149268058381, 10712.196585256293, 10882.40146791934, 10901.182411319025, 11039.227254092137, 12767.93616031914, 12957.676058098623, 13082.672933176747, 13603.591892243248, 14042.0, 11729.35488548138, 12396.0, 13008.349582521025, 13144.27706476153, 13283.80074298867, 11832.112456928495, 12329.136960412685, 12450.315232662291, 12548.749025019266, 12607.810882836948, 11923.105767067678, 11994.340311282964, 12334.629961101182, 12422.0, 12469.127161098999, 9113.41658852194, 9465.290103242422, 9598.184154346958, 9656.179224765974, 9814.263930205407, 8395.24442800151, 8755.518446485505, 9339.486328252011, 9683.080107389787, 9689.806203875742], "value": 6413.671252412073, "unit": "score"}], "name": "dromaeo_css", "value": 6353.510205327409, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 115.0, 114.0, 116.0, 114.0, 114.0, 115.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 123.0, 158.0, 125.0, 125.0, 131.0, 123.0, 146.0, 126.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 164.0, 162.0, 162.0, 161.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 110.0, 77.0, 77.0, 78.0, 76.0, 92.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 106.0, 86.0, 85.0, 84.0, 102.0, 84.0, 84.0, 107.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 60.0, 61.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 68.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 85.0, 87.0, 87.0, 86.0, 86.0, 85.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 139.0, 134.0, 137.0, 133.0, 131.0, 130.0, 138.0, 217.0, 138.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 178.0, 183.0, 178.0, 177.0, 179.0, 177.0, 178.0, 180.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 67.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1548.2999999999997, "alertThreshold": 2.0}]} 02:22:58 INFO - Return code: 0 02:22:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:58 INFO - # TBPL SUCCESS # 02:22:58 INFO - Running post-action listener: _resource_record_post_action 02:22:58 INFO - [mozharness: 2017-01-09 10:22:58.199336Z] Finished run-tests step (success) 02:22:58 INFO - Running post-run listener: _resource_record_post_run 02:22:58 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282902528; Read time: 112; Write time: 152236 02:22:58 INFO - TinderboxPrint: CPU usage
13.1% 02:22:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 02:22:58 INFO - TinderboxPrint: I/O write bytes / time
282,902,528 / 152,236 02:22:58 INFO - TinderboxPrint: CPU idle
8,338.8 (86.9%) 02:22:58 INFO - TinderboxPrint: CPU user
1,211.6 (12.6%) 02:22:58 INFO - TinderboxPrint: Swap in / out
0 / 0 02:22:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 700416; Read time: 0; Write time: 44 02:22:58 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282202112; Read time: 96; Write time: 152192 02:22:58 INFO - Running post-run listener: _upload_blobber_files 02:22:58 INFO - Blob upload gear active. 02:22:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:22:58 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:22:58 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:23:01 INFO - (blobuploader) - INFO - Open directory for files ... 02:23:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:23:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:23:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:08 INFO - (blobuploader) - INFO - Done attempting. 02:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:13 INFO - (blobuploader) - INFO - Done attempting. 02:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:23:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:24 INFO - (blobuploader) - INFO - Done attempting. 02:23:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:23:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:23:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:30 INFO - (blobuploader) - INFO - Done attempting. 02:23:30 INFO - (blobuploader) - INFO - Iteration through files over. 02:23:30 INFO - Return code: 0 02:23:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:23:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:23:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7f3ce66f84220d103c674788a564c3c4b5dc4db8ce49dde1aaf27d33ee561cdd313cf216f175e07f66818ba0dc6745cd5f47d7f2fca7837a1fbd08338da4058", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/028bb727dda7688e2e3975222041ee1a02541ce7ec1d4d19862f465a5e20d8ff1458b6104e1f7bc91260e00036525194d20c27368fafcc7473bec15f78e88cdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a92ea8af245fc0f6cf2928872e05aaa50fc4295a21aaec1d6d982de52866cfd891edd6ce8c8bebc498cf1d9a28c700dd0dd0813069e8f2ac11cc472fa6cf80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5b1f1b844946d4cdfae6bb3106a068741db634796515bac9397f84421ae4e6e97107690f832f8b40021682b16ed506dea1c84956592c2684700adaf694147ca"} 02:23:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:23:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:23:30 INFO - Contents: 02:23:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7f3ce66f84220d103c674788a564c3c4b5dc4db8ce49dde1aaf27d33ee561cdd313cf216f175e07f66818ba0dc6745cd5f47d7f2fca7837a1fbd08338da4058", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/028bb727dda7688e2e3975222041ee1a02541ce7ec1d4d19862f465a5e20d8ff1458b6104e1f7bc91260e00036525194d20c27368fafcc7473bec15f78e88cdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a92ea8af245fc0f6cf2928872e05aaa50fc4295a21aaec1d6d982de52866cfd891edd6ce8c8bebc498cf1d9a28c700dd0dd0813069e8f2ac11cc472fa6cf80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5b1f1b844946d4cdfae6bb3106a068741db634796515bac9397f84421ae4e6e97107690f832f8b40021682b16ed506dea1c84956592c2684700adaf694147ca"} 02:23:30 INFO - Running post-run listener: copy_logs_to_upload_dir 02:23:30 INFO - Copying logs to upload dir... 02:23:30 INFO - mkdir: /builds/slave/test/build/upload/logs 02:23:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.915272 ========= master_lag: 4.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-01-09 02:23:35.046879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:35.050616) ========= 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=00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7f3ce66f84220d103c674788a564c3c4b5dc4db8ce49dde1aaf27d33ee561cdd313cf216f175e07f66818ba0dc6745cd5f47d7f2fca7837a1fbd08338da4058", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/028bb727dda7688e2e3975222041ee1a02541ce7ec1d4d19862f465a5e20d8ff1458b6104e1f7bc91260e00036525194d20c27368fafcc7473bec15f78e88cdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a92ea8af245fc0f6cf2928872e05aaa50fc4295a21aaec1d6d982de52866cfd891edd6ce8c8bebc498cf1d9a28c700dd0dd0813069e8f2ac11cc472fa6cf80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5b1f1b844946d4cdfae6bb3106a068741db634796515bac9397f84421ae4e6e97107690f832f8b40021682b16ed506dea1c84956592c2684700adaf694147ca"} build_url:https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/TKRNz3LhRaiB-kHVwgBa7A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7f3ce66f84220d103c674788a564c3c4b5dc4db8ce49dde1aaf27d33ee561cdd313cf216f175e07f66818ba0dc6745cd5f47d7f2fca7837a1fbd08338da4058", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/028bb727dda7688e2e3975222041ee1a02541ce7ec1d4d19862f465a5e20d8ff1458b6104e1f7bc91260e00036525194d20c27368fafcc7473bec15f78e88cdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a92ea8af245fc0f6cf2928872e05aaa50fc4295a21aaec1d6d982de52866cfd891edd6ce8c8bebc498cf1d9a28c700dd0dd0813069e8f2ac11cc472fa6cf80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5b1f1b844946d4cdfae6bb3106a068741db634796515bac9397f84421ae4e6e97107690f832f8b40021682b16ed506dea1c84956592c2684700adaf694147ca"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:35.220894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:35.221235) ========= 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=00204705a9daa57ed339a427000001b9-1483955412.628512-1710188937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:35.271184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:23:35.271497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:23:35.271793) ========= ========= Total master_lag: 4.59 =========