builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1493886861.03 results: success (0) revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.034841) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.035227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.035509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.050997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.051251) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 01:34:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.0M=0s 2017-05-04 01:34:21 (68.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135702 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.202106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.202395) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020258 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.253691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.253978) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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=652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 01:34:21,593 truncating revision to first 12 chars 2017-05-04 01:34:21,593 Setting DEBUG logging. 2017-05-04 01:34:21,593 attempt 1/10 2017-05-04 01:34:21,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 01:34:21,907 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693026 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.962976) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.963273) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.966664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.966929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 01:34:21.977812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-04 01:34:21.978071) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:34:22 INFO - MultiFileLogger online at 20170504 01:34:22 in /builds/slave/test 01:34:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 01:34:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:34:22 INFO - {'append_to_log': False, 01:34:22 INFO - 'base_work_dir': '/builds/slave/test', 01:34:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:34:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:34:22 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:34:22 INFO - 'buildbot_json_path': 'buildprops.json', 01:34:22 INFO - 'config_files': ('talos/linux_config.py',), 01:34:22 INFO - 'default_actions': ('clobber', 01:34:22 INFO - 'read-buildbot-config', 01:34:22 INFO - 'download-and-extract', 01:34:22 INFO - 'populate-webroot', 01:34:22 INFO - 'create-virtualenv', 01:34:22 INFO - 'install', 01:34:22 INFO - 'run-tests'), 01:34:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:34:22 INFO - 'download_minidump_stackwalk': True, 01:34:22 INFO - 'download_symbols': 'ondemand', 01:34:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:34:22 INFO - 'tooltool.py': '/tools/tooltool.py', 01:34:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:34:22 INFO - '/tools/misc-python/virtualenv.py')}, 01:34:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:34:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:34:22 INFO - 'gecko_profile': False, 01:34:22 INFO - 'gecko_profile_interval': 0, 01:34:22 INFO - 'installer_path': 'installer.exe', 01:34:22 INFO - 'log_level': 'info', 01:34:22 INFO - 'log_name': 'talos', 01:34:22 INFO - 'log_to_console': True, 01:34:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:34:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:34:22 INFO - 'opt_config_files': (), 01:34:22 INFO - 'pip_index': False, 01:34:22 INFO - 'suite': 'dromaeojs', 01:34:22 INFO - 'system_bits': '32', 01:34:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:34:22 INFO - 'title': 'talos-linux64-ix-046', 01:34:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:34:22 INFO - 'use_talos_json': True, 01:34:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:34:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:34:22 INFO - 'work_dir': 'build'} 01:34:22 INFO - [mozharness: 2017-05-04 08:34:22.410547Z] Running clobber step. 01:34:22 INFO - Running pre-action listener: _resource_record_pre_action 01:34:22 INFO - Running main action method: clobber 01:34:22 INFO - rmtree: /builds/slave/test/build 01:34:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:34:23 INFO - Running post-action listener: _resource_record_post_action 01:34:23 INFO - [mozharness: 2017-05-04 08:34:23.354257Z] Finished clobber step (success) 01:34:23 INFO - [mozharness: 2017-05-04 08:34:23.354355Z] Running read-buildbot-config step. 01:34:23 INFO - Running pre-action listener: _resource_record_pre_action 01:34:23 INFO - Running main action method: read_buildbot_config 01:34:23 INFO - Using buildbot properties: 01:34:23 INFO - { 01:34:23 INFO - "project": "", 01:34:23 INFO - "product": "firefox", 01:34:23 INFO - "who": "nobody@mozilla.org", 01:34:23 INFO - "installer_path": "public/build/target.tar.bz2", 01:34:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:34:23 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:34:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:34:23 INFO - "stage_platform": "linux64", 01:34:23 INFO - "basedir": "/builds/slave/test", 01:34:23 INFO - "buildnumber": 145, 01:34:23 INFO - "platform": "ubuntu64_hw", 01:34:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:34:23 INFO - "slavebuilddir": "test", 01:34:23 INFO - "taskId": "DCvHx6_1TGWXk5oU1YUewg", 01:34:23 INFO - "branch": "mozilla-aurora", 01:34:23 INFO - "script_repo_revision": "production", 01:34:23 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:34:23 INFO - "slavename": "talos-linux64-ix-046", 01:34:23 INFO - "repo_path": "releases/mozilla-aurora" 01:34:23 INFO - } 01:34:23 INFO - Finding installer, test and symbols from parent task. 01:34:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DCvHx6_1TGWXk5oU1YUewg'}, attempt #1 01:34:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DCvHx6_1TGWXk5oU1YUewg'}, attempt #1 01:34:24 INFO - Task dependencies: Q9rlsIaqQLiHleSG6SiT5g 01:34:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g'}, attempt #1 01:34:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2 01:34:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/test_packages.json 01:34:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.crashreporter-symbols.zip 01:34:24 INFO - Running post-action listener: _resource_record_post_action 01:34:24 INFO - [mozharness: 2017-05-04 08:34:24.724960Z] Finished read-buildbot-config step (success) 01:34:24 INFO - [mozharness: 2017-05-04 08:34:24.725178Z] Running download-and-extract step. 01:34:24 INFO - Running pre-action listener: _resource_record_pre_action 01:34:24 INFO - Running main action method: download_and_extract 01:34:24 INFO - mkdir: /builds/slave/test/build/tests 01:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:24 INFO - trying https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.test_packages.json 01:34:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:34:25 INFO - Downloaded 896 bytes. 01:34:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:34:25 INFO - Using the following test package requirements: 01:34:25 INFO - {u'common': [u'target.common.tests.zip'], 01:34:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:34:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:34:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:34:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:34:25 INFO - u'mozbase': [u'target.common.tests.zip'], 01:34:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:34:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:34:25 INFO - u'web-platform': [u'target.common.tests.zip', 01:34:25 INFO - u'target.web-platform.tests.zip'], 01:34:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:34:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:34:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.common.tests.zip 01:34:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:34:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.common.tests.zip into memory 01:34:26 INFO - Expected file size: 59549193 01:34:26 INFO - Obtained file size: 59549193 01:34:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:34:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.common.tests.zip 01:34:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:34:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.common.tests.zip into memory 01:34:37 INFO - Expected file size: 59549193 01:34:37 INFO - Obtained file size: 59549193 01:34:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.talos.tests.zip 01:34:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:34:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.talos.tests.zip into memory 01:34:48 INFO - Expected file size: 14404424 01:34:48 INFO - Obtained file size: 14404424 01:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:48 INFO - trying https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2 01:34:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:34:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:34:50 INFO - Downloaded 66714906 bytes. 01:34:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2 01:34:50 INFO - mkdir: /builds/slave/test/properties 01:34:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:50 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:50 INFO - Contents: 01:34:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2 01:34:50 INFO - Running post-action listener: _resource_record_post_action 01:34:50 INFO - Running post-action listener: set_extra_try_arguments 01:34:50 INFO - [mozharness: 2017-05-04 08:34:50.802324Z] Finished download-and-extract step (success) 01:34:50 INFO - [mozharness: 2017-05-04 08:34:50.802421Z] Running populate-webroot step. 01:34:50 INFO - Running pre-action listener: _resource_record_pre_action 01:34:50 INFO - Running main action method: populate_webroot 01:34:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:50 INFO - '--tppagecycles', 01:34:50 INFO - '7'], 01:34:50 INFO - 'tests': ['tsvgm']}}, 01:34:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:34:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:34:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:34:50 INFO - 'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:34:50 INFO - 'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['damp', 'tps']}, 01:34:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:34:50 INFO - 'tests': ['damp', 'tps']}, 01:34:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['dromaeo_dom']}, 01:34:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['basic_compositor_video']}, 01:34:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:34:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['a11yr', 01:34:50 INFO - 'ts_paint', 01:34:50 INFO - 'tpaint', 01:34:50 INFO - 'sessionrestore', 01:34:50 INFO - 'sessionrestore_no_auto_restore', 01:34:50 INFO - 'tabpaint']}, 01:34:50 INFO - 'other-e10s': {'tests': ['a11yr', 01:34:50 INFO - 'ts_paint', 01:34:50 INFO - 'tpaint', 01:34:50 INFO - 'sessionrestore', 01:34:50 INFO - 'sessionrestore_no_auto_restore', 01:34:50 INFO - 'tabpaint']}, 01:34:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:34:50 INFO - 'ts_paint', 01:34:50 INFO - 'tpaint', 01:34:50 INFO - 'sessionrestore', 01:34:50 INFO - 'sessionrestore_no_auto_restore', 01:34:50 INFO - 'tabpaint']}, 01:34:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:34:50 INFO - 'ts_paint', 01:34:50 INFO - 'tpaint', 01:34:50 INFO - 'sessionrestore', 01:34:50 INFO - 'sessionrestore_no_auto_restore', 01:34:50 INFO - 'tabpaint']}, 01:34:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['a11yr', 01:34:50 INFO - 'ts_paint', 01:34:50 INFO - 'tpaint', 01:34:50 INFO - 'sessionrestore', 01:34:50 INFO - 'sessionrestore_no_auto_restore', 01:34:50 INFO - 'tabpaint']}, 01:34:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['a11yr', 01:34:50 INFO - 'ts_paint', 01:34:50 INFO - 'tpaint', 01:34:50 INFO - 'sessionrestore', 01:34:50 INFO - 'sessionrestore_no_auto_restore', 01:34:50 INFO - 'tabpaint']}, 01:34:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['tsvgx', 01:34:50 INFO - 'tsvgr_opacity', 01:34:50 INFO - 'tart', 01:34:50 INFO - 'tscrollx', 01:34:50 INFO - 'cart', 01:34:50 INFO - 'tsvg_static']}, 01:34:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:34:50 INFO - 'tsvgr_opacity', 01:34:50 INFO - 'tart', 01:34:50 INFO - 'tscrollx', 01:34:50 INFO - 'cart', 01:34:50 INFO - 'tsvg_static']}, 01:34:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:34:50 INFO - 'talos_options': ['--disable-e10s'], 01:34:50 INFO - 'tests': ['tp5o']}, 01:34:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:34:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:34:50 INFO - 'talos_options': ['--disable-e10s', 01:34:50 INFO - '--xperf_path', 01:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:50 INFO - 'tests': ['tp5n']}, 01:34:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:34:50 INFO - 'talos_options': ['--xperf_path', 01:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:50 INFO - 'tests': ['tp5n']}}, 01:34:50 INFO - 'talos.zip': {'path': '', 01:34:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:50 INFO - Running post-action listener: _resource_record_post_action 01:34:50 INFO - [mozharness: 2017-05-04 08:34:50.815522Z] Finished populate-webroot step (success) 01:34:50 INFO - [mozharness: 2017-05-04 08:34:50.815612Z] Running create-virtualenv step. 01:34:50 INFO - Running pre-action listener: _resource_record_pre_action 01:34:50 INFO - Running main action method: create_virtualenv 01:34:50 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:50 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 01:34:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:50 INFO - Using real prefix '/usr' 01:34:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:51 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:53 INFO - Installing pip.................done. 01:34:53 INFO - Return code: 0 01:34:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:34:53 INFO - Reading from file tmpfile_stdout 01:34:53 INFO - Output received: 01:34:53 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) 01:34:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:34:53 INFO - Using env: {'DISPLAY': ':0', 01:34:53 INFO - 'HOME': '/home/cltbld', 01:34:53 INFO - 'LANG': 'en_US.UTF-8', 01:34:53 INFO - 'LANGUAGE': 'en_US:en', 01:34:53 INFO - 'LOGNAME': 'cltbld', 01:34:53 INFO - 'MAIL': '/var/mail/cltbld', 01:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:53 INFO - 'MOZ_NO_REMOTE': '1', 01:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:53 INFO - 'NO_EM_RESTART': '1', 01:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:53 INFO - 'PWD': '/builds/slave/test', 01:34:53 INFO - 'SHELL': '/bin/bash', 01:34:53 INFO - 'SHLVL': '1', 01:34:53 INFO - 'TERM': 'linux', 01:34:53 INFO - 'TMOUT': '86400', 01:34:53 INFO - 'USER': 'cltbld', 01:34:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:53 INFO - '_': '/tools/buildbot/bin/python'} 01:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:53 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 01:34:53 INFO - Cleaning up... 01:34:53 INFO - Return code: 0 01:34:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:34:53 INFO - Using env: {'DISPLAY': ':0', 01:34:53 INFO - 'HOME': '/home/cltbld', 01:34:53 INFO - 'LANG': 'en_US.UTF-8', 01:34:53 INFO - 'LANGUAGE': 'en_US:en', 01:34:53 INFO - 'LOGNAME': 'cltbld', 01:34:53 INFO - 'MAIL': '/var/mail/cltbld', 01:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:53 INFO - 'MOZ_NO_REMOTE': '1', 01:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:53 INFO - 'NO_EM_RESTART': '1', 01:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:53 INFO - 'PWD': '/builds/slave/test', 01:34:53 INFO - 'SHELL': '/bin/bash', 01:34:53 INFO - 'SHLVL': '1', 01:34:53 INFO - 'TERM': 'linux', 01:34:53 INFO - 'TMOUT': '86400', 01:34:53 INFO - 'USER': 'cltbld', 01:34:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:53 INFO - '_': '/tools/buildbot/bin/python'} 01:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:54 INFO - Downloading/unpacking psutil>=3.1.1 01:34:54 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 01:34:54 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 01:34:54 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 01:34:54 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 01:34:54 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 01:34:54 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 01:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:55 INFO - Installing collected packages: psutil 01:34:55 INFO - Running setup.py install for psutil 01:34:55 INFO - building 'psutil._psutil_linux' extension 01:34:55 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 01:34:55 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 01:34:55 INFO - building 'psutil._psutil_posix' extension 01:34:55 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 01:34:55 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 01:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:55 INFO - Successfully installed psutil 01:34:55 INFO - Cleaning up... 01:34:55 INFO - Return code: 0 01:34:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:34: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 mozsystemmonitor==0.3 01:34:55 INFO - Using env: {'DISPLAY': ':0', 01:34:55 INFO - 'HOME': '/home/cltbld', 01:34:55 INFO - 'LANG': 'en_US.UTF-8', 01:34:55 INFO - 'LANGUAGE': 'en_US:en', 01:34:55 INFO - 'LOGNAME': 'cltbld', 01:34:55 INFO - 'MAIL': '/var/mail/cltbld', 01:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:55 INFO - 'MOZ_NO_REMOTE': '1', 01:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:55 INFO - 'NO_EM_RESTART': '1', 01:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:55 INFO - 'PWD': '/builds/slave/test', 01:34:55 INFO - 'SHELL': '/bin/bash', 01:34:55 INFO - 'SHLVL': '1', 01:34:55 INFO - 'TERM': 'linux', 01:34:55 INFO - 'TMOUT': '86400', 01:34:55 INFO - 'USER': 'cltbld', 01:34:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:55 INFO - '_': '/tools/buildbot/bin/python'} 01:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:34:57 INFO - Installing collected packages: mozsystemmonitor 01:34:57 INFO - Running setup.py install for mozsystemmonitor 01:34:57 INFO - Successfully installed mozsystemmonitor 01:34:57 INFO - Cleaning up... 01:34:57 INFO - Return code: 0 01:34:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:34:57 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')]} 01:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:57 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')]} 01:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:57 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 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:34:57 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 01:34:57 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 01:34:57 INFO - Using env: {'DISPLAY': ':0', 01:34:57 INFO - 'HOME': '/home/cltbld', 01:34:57 INFO - 'LANG': 'en_US.UTF-8', 01:34:57 INFO - 'LANGUAGE': 'en_US:en', 01:34:57 INFO - 'LOGNAME': 'cltbld', 01:34:57 INFO - 'MAIL': '/var/mail/cltbld', 01:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:57 INFO - 'MOZ_NO_REMOTE': '1', 01:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:57 INFO - 'NO_EM_RESTART': '1', 01:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:57 INFO - 'PWD': '/builds/slave/test', 01:34:57 INFO - 'SHELL': '/bin/bash', 01:34:57 INFO - 'SHLVL': '1', 01:34:57 INFO - 'TERM': 'linux', 01:34:57 INFO - 'TMOUT': '86400', 01:34:57 INFO - 'USER': 'cltbld', 01:34:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:57 INFO - '_': '/tools/buildbot/bin/python'} 01:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:57 INFO - Downloading/unpacking jsonschema==2.5.1 01:34:57 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 01:34:57 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 01:34:57 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 01:34:57 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 01:34:57 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 01:34:57 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 01:34:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:34:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:58 INFO - Downloading functools32-3.2.3-2.tar.gz 01:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:34:58 INFO - warning: no files found matching '*.txt' 01:34:58 INFO - no previously-included directories found matching 'build' 01:34:58 INFO - no previously-included directories found matching 'dist' 01:34:58 INFO - no previously-included directories found matching '.git*' 01:34:58 INFO - Installing collected packages: jsonschema, functools32 01:34:58 INFO - Running setup.py install for functools32 01:34:58 INFO - warning: no files found matching '*.txt' 01:34:58 INFO - no previously-included directories found matching 'build' 01:34:58 INFO - no previously-included directories found matching 'dist' 01:34:58 INFO - no previously-included directories found matching '.git*' 01:34:58 INFO - Successfully installed jsonschema functools32 01:34:58 INFO - Cleaning up... 01:34:58 INFO - Return code: 0 01:34:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:34:58 INFO - Using env: {'DISPLAY': ':0', 01:34:58 INFO - 'HOME': '/home/cltbld', 01:34:58 INFO - 'LANG': 'en_US.UTF-8', 01:34:58 INFO - 'LANGUAGE': 'en_US:en', 01:34:58 INFO - 'LOGNAME': 'cltbld', 01:34:58 INFO - 'MAIL': '/var/mail/cltbld', 01:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:58 INFO - 'MOZ_NO_REMOTE': '1', 01:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:58 INFO - 'NO_EM_RESTART': '1', 01:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:58 INFO - 'PWD': '/builds/slave/test', 01:34:58 INFO - 'SHELL': '/bin/bash', 01:34:58 INFO - 'SHLVL': '1', 01:34:58 INFO - 'TERM': 'linux', 01:34:58 INFO - 'TMOUT': '86400', 01:34:58 INFO - 'USER': 'cltbld', 01:34:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:58 INFO - '_': '/tools/buildbot/bin/python'} 01:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:34:59 INFO - Cleaning up... 01:34:59 INFO - Return code: 0 01:34:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 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 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:34:59 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 01:34:59 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 01:34:59 INFO - Using env: {'DISPLAY': ':0', 01:34:59 INFO - 'HOME': '/home/cltbld', 01:34:59 INFO - 'LANG': 'en_US.UTF-8', 01:34:59 INFO - 'LANGUAGE': 'en_US:en', 01:34:59 INFO - 'LOGNAME': 'cltbld', 01:34:59 INFO - 'MAIL': '/var/mail/cltbld', 01:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:59 INFO - 'MOZ_NO_REMOTE': '1', 01:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:59 INFO - 'NO_EM_RESTART': '1', 01:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:59 INFO - 'PWD': '/builds/slave/test', 01:34:59 INFO - 'SHELL': '/bin/bash', 01:34:59 INFO - 'SHLVL': '1', 01:34:59 INFO - 'TERM': 'linux', 01:34:59 INFO - 'TMOUT': '86400', 01:34:59 INFO - 'USER': 'cltbld', 01:34:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:59 INFO - '_': '/tools/buildbot/bin/python'} 01:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:59 INFO - Downloading/unpacking blobuploader==1.2.4 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:00 INFO - Downloading blobuploader-1.2.4.tar.gz 01:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:35:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:35:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 INFO - Downloading docopt-0.6.1.tar.gz 01:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:35:01 INFO - Installing collected packages: blobuploader, requests, docopt 01:35:01 INFO - Running setup.py install for blobuploader 01:35:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:35:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:35:01 INFO - Running setup.py install for requests 01:35:01 INFO - Running setup.py install for docopt 01:35:01 INFO - Successfully installed blobuploader requests docopt 01:35:01 INFO - Cleaning up... 01:35:01 INFO - Return code: 0 01:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:01 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 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:35:01 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 01:35:01 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 01:35:01 INFO - Using env: {'DISPLAY': ':0', 01:35:01 INFO - 'HOME': '/home/cltbld', 01:35:01 INFO - 'LANG': 'en_US.UTF-8', 01:35:01 INFO - 'LANGUAGE': 'en_US:en', 01:35:01 INFO - 'LOGNAME': 'cltbld', 01:35:01 INFO - 'MAIL': '/var/mail/cltbld', 01:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:01 INFO - 'MOZ_NO_REMOTE': '1', 01:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:01 INFO - 'NO_EM_RESTART': '1', 01:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:01 INFO - 'PWD': '/builds/slave/test', 01:35:01 INFO - 'SHELL': '/bin/bash', 01:35:01 INFO - 'SHLVL': '1', 01:35:01 INFO - 'TERM': 'linux', 01:35:01 INFO - 'TMOUT': '86400', 01:35:01 INFO - 'USER': 'cltbld', 01:35:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:01 INFO - '_': '/tools/buildbot/bin/python'} 01:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:01 INFO - Running setup.py (path:/tmp/pip-qvf7bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:01 INFO - Running setup.py (path:/tmp/pip-vB4KVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:02 INFO - Running setup.py (path:/tmp/pip-kEO9FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:02 INFO - Running setup.py (path:/tmp/pip-Dok6pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:02 INFO - Running setup.py (path:/tmp/pip-q5bf7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:02 INFO - Running setup.py (path:/tmp/pip-GPP4Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:02 INFO - Running setup.py (path:/tmp/pip-qEA7HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:02 INFO - Running setup.py (path:/tmp/pip-AUJssO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:02 INFO - Running setup.py (path:/tmp/pip-42hXR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:02 INFO - Running setup.py (path:/tmp/pip-O2NlX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:02 INFO - Running setup.py (path:/tmp/pip-MHXo77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:02 INFO - Running setup.py (path:/tmp/pip-DiSuBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:02 INFO - Running setup.py (path:/tmp/pip-A1KRXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:02 INFO - Running setup.py (path:/tmp/pip-ZMz895-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:02 INFO - Running setup.py (path:/tmp/pip-Fojr8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:03 INFO - Running setup.py (path:/tmp/pip-YhdqnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:03 INFO - Running setup.py (path:/tmp/pip-SXIGIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:35:03 INFO - Running setup.py install for manifestparser 01:35:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Running setup.py install for mozcrash 01:35:03 INFO - Running setup.py install for mozdebug 01:35:03 INFO - Running setup.py install for mozdevice 01:35:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Running setup.py install for mozfile 01:35:03 INFO - Running setup.py install for mozhttpd 01:35:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Running setup.py install for mozinfo 01:35:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Running setup.py install for mozInstall 01:35:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:35:03 INFO - Running setup.py install for mozleak 01:35:04 INFO - Running setup.py install for mozlog 01:35:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Running setup.py install for moznetwork 01:35:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Running setup.py install for mozprocess 01:35:04 INFO - Running setup.py install for mozprofile 01:35:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Running setup.py install for mozrunner 01:35:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Running setup.py install for mozscreenshot 01:35:04 INFO - Running setup.py install for moztest 01:35:04 INFO - Running setup.py install for mozversion 01:35:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:35:04 INFO - Cleaning up... 01:35:04 INFO - Return code: 0 01:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:04 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 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:35:04 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 01:35:04 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 01:35:04 INFO - Using env: {'DISPLAY': ':0', 01:35:04 INFO - 'HOME': '/home/cltbld', 01:35:04 INFO - 'LANG': 'en_US.UTF-8', 01:35:04 INFO - 'LANGUAGE': 'en_US:en', 01:35:04 INFO - 'LOGNAME': 'cltbld', 01:35:04 INFO - 'MAIL': '/var/mail/cltbld', 01:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:04 INFO - 'MOZ_NO_REMOTE': '1', 01:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:04 INFO - 'NO_EM_RESTART': '1', 01:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:04 INFO - 'PWD': '/builds/slave/test', 01:35:04 INFO - 'SHELL': '/bin/bash', 01:35:04 INFO - 'SHLVL': '1', 01:35:04 INFO - 'TERM': 'linux', 01:35:04 INFO - 'TMOUT': '86400', 01:35:04 INFO - 'USER': 'cltbld', 01:35:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:04 INFO - '_': '/tools/buildbot/bin/python'} 01:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:05 INFO - Running setup.py (path:/tmp/pip-D3ELPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:05 INFO - Running setup.py (path:/tmp/pip-KQeB51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:05 INFO - Running setup.py (path:/tmp/pip-l1Rm63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:05 INFO - Running setup.py (path:/tmp/pip-Kk9Dnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:05 INFO - Running setup.py (path:/tmp/pip-p0kmTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:05 INFO - Running setup.py (path:/tmp/pip-OePEKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:05 INFO - Running setup.py (path:/tmp/pip-Dhye3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:05 INFO - Running setup.py (path:/tmp/pip-bSlSW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:05 INFO - Running setup.py (path:/tmp/pip-jUQtPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:05 INFO - Running setup.py (path:/tmp/pip-lW8qP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:05 INFO - Running setup.py (path:/tmp/pip-NHOGdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:05 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)) 01:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:05 INFO - Running setup.py (path:/tmp/pip-LxxtMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 01:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:06 INFO - Running setup.py (path:/tmp/pip-asOmYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:06 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)) 01:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:06 INFO - Running setup.py (path:/tmp/pip-wJL9DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:06 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)) 01:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:06 INFO - Running setup.py (path:/tmp/pip-g5kF2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:06 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)) 01:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:06 INFO - Running setup.py (path:/tmp/pip-bohefB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:06 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)) 01:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:06 INFO - Running setup.py (path:/tmp/pip-7WjUf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:06 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)) 01:35:06 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)) 01:35:06 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)) 01:35:06 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)) 01:35:06 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)) 01:35:06 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)) 01:35:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:07 INFO - Downloading blessings-1.6.tar.gz 01:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:35:07 INFO - Installing collected packages: blessings 01:35:07 INFO - Running setup.py install for blessings 01:35:07 INFO - Successfully installed blessings 01:35:07 INFO - Cleaning up... 01:35:07 INFO - Return code: 0 01:35:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:07 INFO - Reading from file tmpfile_stdout 01:35:07 INFO - Current package versions: 01:35:07 INFO - argparse == 1.2.1 01:35:07 INFO - blessings == 1.6 01:35:07 INFO - blobuploader == 1.2.4 01:35:07 INFO - docopt == 0.6.1 01:35:07 INFO - functools32 == 3.2.3-2 01:35:07 INFO - jsonschema == 2.5.1 01:35:07 INFO - manifestparser == 1.1 01:35:07 INFO - mozInstall == 1.12 01:35:07 INFO - mozcrash == 1.0 01:35:07 INFO - mozdebug == 0.1 01:35:07 INFO - mozdevice == 0.49 01:35:07 INFO - mozfile == 1.2 01:35:07 INFO - mozhttpd == 0.7 01:35:07 INFO - mozinfo == 0.9 01:35:07 INFO - mozleak == 0.1 01:35:07 INFO - mozlog == 3.4 01:35:07 INFO - moznetwork == 0.27 01:35:07 INFO - mozprocess == 0.25 01:35:07 INFO - mozprofile == 0.28 01:35:07 INFO - mozrunner == 6.13 01:35:07 INFO - mozscreenshot == 0.1 01:35:07 INFO - mozsystemmonitor == 0.3 01:35:07 INFO - moztest == 0.8 01:35:07 INFO - mozversion == 1.4 01:35:07 INFO - psutil == 3.1.1 01:35:07 INFO - requests == 1.2.3 01:35:07 INFO - wsgiref == 0.1.2 01:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35: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')]} 01:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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')]} 01:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:35:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:35:07 INFO - Using env: {'DISPLAY': ':0', 01:35:07 INFO - 'HOME': '/home/cltbld', 01:35:07 INFO - 'LANG': 'en_US.UTF-8', 01:35:07 INFO - 'LANGUAGE': 'en_US:en', 01:35:07 INFO - 'LOGNAME': 'cltbld', 01:35:07 INFO - 'MAIL': '/var/mail/cltbld', 01:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:07 INFO - 'MOZ_NO_REMOTE': '1', 01:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:07 INFO - 'NO_EM_RESTART': '1', 01:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:07 INFO - 'PWD': '/builds/slave/test', 01:35:07 INFO - 'SHELL': '/bin/bash', 01:35:07 INFO - 'SHLVL': '1', 01:35:07 INFO - 'TERM': 'linux', 01:35:07 INFO - 'TMOUT': '86400', 01:35:07 INFO - 'USER': 'cltbld', 01:35:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:07 INFO - '_': '/tools/buildbot/bin/python'} 01:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 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)) 01:35:08 INFO - Cleaning up... 01:35:08 INFO - Return code: 0 01:35:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:08 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 0x120f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, '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': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', '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 01:35:08 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 01:35:08 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 01:35:08 INFO - Using env: {'DISPLAY': ':0', 01:35:08 INFO - 'HOME': '/home/cltbld', 01:35:08 INFO - 'LANG': 'en_US.UTF-8', 01:35:08 INFO - 'LANGUAGE': 'en_US:en', 01:35:08 INFO - 'LOGNAME': 'cltbld', 01:35:08 INFO - 'MAIL': '/var/mail/cltbld', 01:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:08 INFO - 'MOZ_NO_REMOTE': '1', 01:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:08 INFO - 'NO_EM_RESTART': '1', 01:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:08 INFO - 'PWD': '/builds/slave/test', 01:35:08 INFO - 'SHELL': '/bin/bash', 01:35:08 INFO - 'SHLVL': '1', 01:35:08 INFO - 'TERM': 'linux', 01:35:08 INFO - 'TMOUT': '86400', 01:35:08 INFO - 'USER': 'cltbld', 01:35:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:08 INFO - '_': '/tools/buildbot/bin/python'} 01:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:35:08 INFO - Cleaning up... 01:35:08 INFO - Return code: 0 01:35:08 INFO - Running post-action listener: _resource_record_post_action 01:35:08 INFO - Running post-action listener: _start_resource_monitoring 01:35:08 INFO - Starting resource monitoring. 01:35:08 INFO - [mozharness: 2017-05-04 08:35:08.398602Z] Finished create-virtualenv step (success) 01:35:08 INFO - [mozharness: 2017-05-04 08:35:08.399072Z] Running install step. 01:35:08 INFO - Running pre-action listener: _resource_record_pre_action 01:35:08 INFO - Running main action method: install 01:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:08 INFO - Reading from file tmpfile_stdout 01:35:08 INFO - Detecting whether we're running mozinstall >=1.0... 01:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:35:08 INFO - Reading from file tmpfile_stdout 01:35:08 INFO - Output received: 01:35:08 INFO - Usage: mozinstall [options] installer 01:35:08 INFO - Options: 01:35:08 INFO - -h, --help show this help message and exit 01:35:08 INFO - -d DEST, --destination=DEST 01:35:08 INFO - Directory to install application into. [default: 01:35:08 INFO - "/builds/slave/test"] 01:35:08 INFO - --app=APP Application being installed. [default: firefox] 01:35:08 INFO - mkdir: /builds/slave/test/build/application 01:35:08 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'] 01:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:35:25 INFO - Reading from file tmpfile_stdout 01:35:25 INFO - Output received: 01:35:25 INFO - /builds/slave/test/build/application/firefox/firefox 01:35:25 INFO - Running post-action listener: _resource_record_post_action 01:35:25 INFO - [mozharness: 2017-05-04 08:35:25.666852Z] Finished install step (success) 01:35:25 INFO - [mozharness: 2017-05-04 08:35:25.667187Z] Running run-tests step. 01:35:25 INFO - Running pre-action listener: _resource_record_pre_action 01:35:25 INFO - Running main action method: run_tests 01:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:25 INFO - Python 2.7.3 01:35:25 INFO - Return code: 0 01:35:25 INFO - grabbing minidump binary from tooltool 01:35:25 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')]} 01:35:25 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 0x14aa400>, '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 0x14ab3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ab840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:25 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 01:35:25 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 01:35:25 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 01:35:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:25 INFO - Return code: 0 01:35:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:35:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:25 INFO - ENV: RUST_BACKTRACE is now 1 01:35:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:35:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 01:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 01:35:25 INFO - Using env: {'DISPLAY': ':0', 01:35:25 INFO - 'HOME': '/home/cltbld', 01:35:25 INFO - 'LANG': 'en_US.UTF-8', 01:35:25 INFO - 'LANGUAGE': 'en_US:en', 01:35:25 INFO - 'LOGNAME': 'cltbld', 01:35:25 INFO - 'MAIL': '/var/mail/cltbld', 01:35:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:25 INFO - 'MOZ_NO_REMOTE': '1', 01:35:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:25 INFO - 'NO_EM_RESTART': '1', 01:35:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:25 INFO - 'PWD': '/builds/slave/test', 01:35:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:25 INFO - 'RUST_BACKTRACE': '1', 01:35:25 INFO - 'SHELL': '/bin/bash', 01:35:25 INFO - 'SHLVL': '1', 01:35:25 INFO - 'TERM': 'linux', 01:35:25 INFO - 'TMOUT': '86400', 01:35:25 INFO - 'USER': 'cltbld', 01:35:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652', 01:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:25 INFO - '_': '/tools/buildbot/bin/python'} 01:35:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 01:35:25 INFO - mozversion application_buildid: 20170504074822 01:35:25 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:35:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:35:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:25 INFO - mozversion application_name: Firefox 01:35:25 INFO - mozversion application_remotingname: firefox-dev 01:35:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:25 INFO - mozversion application_vendor: Mozilla 01:35:25 INFO - mozversion application_version: 54.0a2 01:35:25 INFO - mozversion platform_buildid: 20170504074822 01:35:25 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:35:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:25 INFO - mozversion platform_version: 54.0a2 01:35:25 INFO - using testdate: 1493886925 01:35:25 INFO - actual date: 1493886925 01:35:25 INFO - starting webserver on 'localhost:33543' 01:35:25 INFO - SUITE-START | Running 2 tests 01:35:25 INFO - TEST-START | dromaeo_css 01:35:25 INFO - operating with platform_type : linux_ 01:35:25 INFO - Initialising browser for dromaeo_css test... 01:35:25 INFO - TEST-INFO | started process 25744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5AgZp_/profile http://localhost:33543/getInfo.html) 01:35:30 INFO - PROCESS | 25744 | __metrics Screen width/height:1600/1200 01:35:30 INFO - PROCESS | 25744 | colorDepth:24 01:35:30 INFO - PROCESS | 25744 | Browser inner width/height: 1024/697 01:35:30 INFO - PROCESS | 25744 | __metrics 01:35:31 INFO - PROCESS | 25744 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:35:31 INFO - PROCESS | 25744 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:35:31 INFO - PROCESS | 25744 | console.error: PushService: 01:35:31 INFO - PROCESS | 25744 | stateChangeProcessEnqueue: Error transitioning state 01:35:31 INFO - PROCESS | 25744 | UnknownError 01:35:31 INFO - TEST-INFO | 25744: exit 0 01:35:31 INFO - Browser initialized. 01:35:31 INFO - Running cycle 1/1 for dromaeo_css test... 01:35:31 INFO - TEST-INFO | started process 25839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5AgZp_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:43 INFO - PROCESS | 25839 | RSS: Main: 140079104 01:35:43 INFO - PROCESS | 25839 | 01:38:45 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33543/tests/dromaeo/cssquery-ext.html) 01:38:46 INFO - PROCESS | 25839 | RSS: Main: 286453760 01:38:46 INFO - PROCESS | 25839 | 01:40:34 INFO - PROCESS | 25839 | ************************* 01:40:34 INFO - PROCESS | 25839 | A coding exception was thrown and uncaught in a Task. 01:40:34 INFO - PROCESS | 25839 | 01:40:34 ERROR - PROCESS | 25839 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:34 INFO - PROCESS | 25839 | Full stack: 01:40:34 INFO - PROCESS | 25839 | ************************* 01:40:34 INFO - PROCESS | 25839 | ************************* 01:40:34 INFO - PROCESS | 25839 | A coding exception was thrown and uncaught in a Task. 01:40:34 INFO - PROCESS | 25839 | 01:40:34 ERROR - PROCESS | 25839 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:34 INFO - PROCESS | 25839 | Full stack: 01:40:34 INFO - PROCESS | 25839 | ************************* 01:40:34 INFO - PROCESS | 25839 | ************************* 01:40:34 INFO - PROCESS | 25839 | A coding exception was thrown and uncaught in a Task. 01:40:34 INFO - PROCESS | 25839 | 01:40:34 ERROR - PROCESS | 25839 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:34 INFO - PROCESS | 25839 | Full stack: 01:40:34 INFO - PROCESS | 25839 | ************************* 01:40:34 INFO - PROCESS | 25839 | ************************* 01:40:34 INFO - PROCESS | 25839 | A coding exception was thrown and uncaught in a Task. 01:40:34 INFO - PROCESS | 25839 | 01:40:34 ERROR - PROCESS | 25839 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:34 INFO - PROCESS | 25839 | Full stack: 01:40:34 INFO - PROCESS | 25839 | ************************* 01:41:49 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-ext.html (next: http://localhost:33543/tests/dromaeo/cssquery-jquery.html) 01:41:49 INFO - PROCESS | 25839 | RSS: Main: 221941760 01:41:49 INFO - PROCESS | 25839 | 01:44:51 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33543/tests/dromaeo/cssquery-mootools.html) 01:44:52 INFO - PROCESS | 25839 | RSS: Main: 169750528 01:44:52 INFO - PROCESS | 25839 | 01:47:54 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33543/tests/dromaeo/cssquery-prototype.html) 01:47:54 INFO - PROCESS | 25839 | RSS: Main: 171134976 01:47:54 INFO - PROCESS | 25839 | 01:50:57 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33543/tests/dromaeo/cssquery-yui.html) 01:50:58 INFO - PROCESS | 25839 | RSS: Main: 177160192 01:50:58 INFO - PROCESS | 25839 | 01:54:00 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-yui.html (next: http://localhost:33543/tests/dromaeo/cssquery-dojo.html) 01:54:01 INFO - PROCESS | 25839 | RSS: Main: 259985408 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | __start_tp_report 01:54:01 INFO - PROCESS | 25839 | _x_x_mozilla_page_load 01:54:01 INFO - PROCESS | 25839 | _x_x_mozilla_page_load_details 01:54:01 INFO - PROCESS | 25839 | |i|pagename|runs| 01:54:01 INFO - PROCESS | 25839 | |0;dojo.html;3376.5272861799344;3483.1640406302495;3490.4066308727506;3510.7893526388434;3530.6645868642486;5825.766969321227;5869.060950247961;5914.763409463616;5919.112133180025;5936.3470018298;5899.793507227248;5940.37626049264;5959.672218028007;5960.5529585281065;5968.582199246054;5373.247745315659;5393.973030134844;5423.511883930445;5426.104692725696;5455.563554915617;5111.258867464216;5119.923201151985;5472.26124473195;5491.862703432426;5495.8351249462385;5303.946960530384;5306.946930530684;5426.701531415771;5438.456154384569;5450.264214331074;5436.3476382834315;5446.455354464521;5457.972710136443;5458.263134476854;5467.152591348347;5115.2071428928575;5322.7072511011875;5364.544013758835;5401.054815407288;5466.945330546683;5718.799842005551;5728.112142617901;5739.397363276879;5750;5772.191893134965;6266.78066267683;6284.402981716729;6287.6856157192415;6301.87396252077;6302.590331628429;6337.081123237151;6346.968265158691;6350.745970161188;6351.9364806351805;6361.872762544724;5651.4913657770585;5687.943120568782;5780.335261444946;5819.039858423397;5823;6425.710843011982;6426.132472116298;6426.228852537725;6429.646369449725;6437.613743175424;6104.389561043949;6157.815265542041;6195.721192546346;6197.659128747962;6201.596896201732;6028.758849645965;6058.333583305833;6212.0371342441995;6243.594166379171;6266.467350275187;6302.716377763011;6321.841953951096;6325.746970121144;6328.398802113792;6328.46208072319;5998.4601385875485;6038.607490513103;6040.6677632730625;6134.387509608313;6185.226846644169;4760.09558183944;4797.952020479751;4813.687110337817;4816.109019831342;4831.299461578052;4143.19207754485;4143.461350024538;4236.173946080485;4285.7000009999;4286.442762440863;6048.395160483917;6051.364606716319;6086.756529738849;6088.908666370008;6098.207233059674;6314.652694101776;6338.30278669346;6338.58799178052;6349.746010159542;6350.460210882126;5780.942190578125;5803.7388317524965;6020.879582408327;6034.456898879122;6044.909326360108;5286.894262114736;5292.311999440049;5367.946320536823;5373.11343628297;5379.569634429236;6483.157189565326;6516.446102081281;6525.119108920235;6526.184226971629;6533.575317604341;5899.528037757055;6275.592086514362;6321.494280457644;6325.652089135142;6330.303666596763;6178;6322.8735425290315;6399.7440102395385;6499.870002600016;6518.380753828379;6198.2252218472695;6205.069239614094;6225.221847269091;6226.533010024175;6229.501639868709;6258.530610204162;6313.6843157841;6316.905246421215;6323.620582765049;6325.462335701332;5854.356020837789;5909.468147866713;6020.939790602038;6059.606125601822;6144.525313924715;6135.808695391702;6136.938630613815;6146.108814222002;6146.446819786241;6148.1085242640465;5868.706564671835;6121.575768430891;6149.84625384369;6163.599366041193;6173.41352571505;5950.16697662319;6027;6068.393160684073;6115.388461153849;6177.536684748572;6052.273727152769;6068.696565171812;6075.726592303268;6077.453029227214;6094.695265236809 01:54:01 INFO - PROCESS | 25839 | |1;ext.html;739.7595781371052;794.1462927353095;812.8983877015371;878.617801256453;895.4492986813112;31044.68955310446;43307.78346108269;44401.333979990326;44428.777856110675;44451.55548444515;45758.542414575844;45824.541754582446;45882.541174588245;46021;46142;7720.266574675396;7869.291763741262;9031;9168;9173.724788256362;10496.160307175445;10733.892661073367;10734.087602553793;10735.677929662123;11052.889471105267;10869.510872010778;10924;10935.179861510378;10938.835917461245;10957;10729.302595331317;10744.570217191304;10819.188560857967;10871.347719136877;10879.564817407294;10595.523201455875;10639.787204255948;10643.94678026605;10644.893551064468;10648.680539583826;42441;42791.14417711659;42846.57153428457;42848.78575607133;42879.78560107211;4223.408722778813;4264.0619063806225;4319.200947824663;4407.471103467605;4420.381146639473;30010;30284.69715302863;30520.8473957631;31088.68911310903;31844.522332165037;4222.4299719538085;4390.626796722282;4395.362672412482;4426.579474949875;4430.180416622935;248539;249550;250099;250152;250180;46680.7665961668;46867.29699054517;47117.05765884732;47145;47187;47825.5217447828;48363;48397.27404088942;48419.27371089436;48548.029039419016;15653;15957.680846383008;16019.599510012109;16022.038677679377;16086;10749.623763168407;10935.507902144423;12162.817557736642;13365.33173341329;13447.865521344662;13053.086283960032;13119.672008199681;13181.406836692371;13202.33988300581;13283.402246898913;5361.0618141825025;5388.703621300788;5506.256655351556;5532.486870836967;5553.305836770403;1032.1845741863845;1046.5081411736471;1048.051513380392;1269.752398282326;1274.961751147467;28277.57583636247;30089;30165.245868853453;30316.54525182124;31263.84368078145;1327.0680060131199;1333.3733145421636;1354.2483921423704;1356.8846648035028;1373.7458570164551;15204.923975380274;15293.158876261912;15314.540563783105;15654.373825047098;15686.607834803994;347782;347857;348146;348719;351170;61527;61760.38239617636;61953.38046619476;61981.69009154925;62156.68921655363;1497.5956491747386;1519.5289460267131;1546.3350759173438;1555.8599726024713;1562.7265228584952;27396.58905116385;28633.570496442153;28792;28897.85551072231;28991.855040724662;45490;45648.08703825971;45763.54236457726;45768.54231457643;45785.313220302385;339199;339500;340245;341395;341468;30096.84951575228;37653.435198471496;38635.2272954545;38774.2245155101;38785.6121438782;39993.60006400015;45560;48712.269315961;49448.25827612517;50150;34830;35458.29083418369;35492.467612986344;35857;35932;34940.47589286214;35011.82494087513;35248.295034098664;35250.471242930864;35259.47110793289;40321.798391007855;40431.79784101179;40897.59102408938;40980.79509602433;41881.581184187766;34039.65960340464;34182.82908585441;34338;34389.312213756086;34534;26983.460330793667;27570.893739047922;27630.309242269104;27752.306192345353;27764 01:54:01 INFO - PROCESS | 25839 | |2;jquery.html;453.4830293465448;457.81197791730466;461.9236531789604;477.31981925755787;482.6066755594191;15327.310271037803;15939.362425502966;18998.810011899877;20159.19363225471;20845.791542084593;20228.69656955147;20291.18835246592;20720.48198795031;20943.16227350908;20946.581068378662;6270.5924114932495;6687.866242675143;6714.865702685944;6715.194176698803;6716.2276338221;6565.146530950994;6680;6727.260001399842;6750.122484077063;6772.695228714695;6736.696848641823;6765.289644587321;6766.966165169168;6767.052612634235;6772.051912732221;6493.967530162343;6594;6594.505412094112;6621;6631.900521492182;6463;6470.644114573696;6478.643674597895;6707.6981535831;7009.82475438113;23349.76650233493;23502.64746028811;23644.645330320058;23771.16800911977;23775.76224237753;3060.525618529109;3083.5683004379407;3090.8145511269395;3104.239461331988;3111.0511294055304;15717.214139293104;15745.68508629821;15989.120598367084;16135.193240337936;16362.018278903184;2266.422062374084;2343.414146463384;2384.666146739458;2396.748341424143;2411.2043025801445;81996;92316.07683923209;107414;111878;112268.43865780701;20810.47973800637;20811.68782468264;20823.8958805205;20910.268140615004;21593.24423645165;42299;42522.36216456756;42579;42721;43129.13741725148;9709.854352184722;10275.02387273208;10319.638812641522;10378.169746420268;10485.475726213659;9160.083991600786;9170.81658366829;9209.953950230207;9409.905900940903;9438.764030899145;8906.886639170103;9345.215187848931;9385.671501497414;9462.29032822541;9469.479178645102;3745.962540374616;3938.448617193595;3946.605339466088;3984.6812255019527;4019.577944315863;925.8981512033671;964.6382606522554;978.5205249427729;980.9902148953854;998.8951160128228;20476;20790.272340468313;20829.479263018547;20859.8957005214;20916.895415522824;937.1331518345503;959.7216807125856;960.4237457525569;961.8268711631973;977.628501169551;11070.169737269736;11372.829407558893;11385.975262226273;11443.084553235722;11452.198346115692;639776;646705;653838;660287;672979;84759.37290367413;90572.54713726521;97680;113005;116126.83873161329;1236.9876301237052;1266.1516783754905;1280.7118398360294;1281.9743605128033;1291.735194285188;18689.439316819975;18932;19013;19088.904555477133;19173.32893348726;51043;51390.22914656358;51396;53262.42340027704;53671.73164134155;67730.66134669296;67877;68066.65966670135;68496.26014959546;68857;11565.074794016291;11954.282743035446;12062.75874482488;12148.696282593006;12150.21023633461;13160.868391316348;13486;13628.591142265748;13685.247311397969;13691.931540342235;11152.888471115184;11421.1434142438;11758.82361764557;11908.106891982963;12527.18573292733;10667.306625069346;10899;11281.71795705114;11408.885911140782;11418;11893.345865977108;11959.402029898296;12042.63872083839;12072.517099315928;12134.75730485403;12119.575814846437;12392.070594705252;12427;12467.316912216735;12528.87471125277;12201.572944946884;12202.633920982385;12340.3212823292;12410.317432540936;12414.503419863104 01:54:01 INFO - PROCESS | 25839 | |3;mootools.html;1539.9230038498072;1573.8819588530855;1583.8336974617657;1585.6749366379893;1595.633004408986;10533.683989480309;11161.776764464716;11164.497597608106;11167.664970050891;11179.385133817637;10817.945910270457;10941.179411544146;11203.439828008588;11521;11552.191346605741;2437.305367970129;2481.10680155144;2481.702195736514;2484.1057219401;2485.7141428735745;2377.4769550698907;2424.200013995386;2472.208893154191;2474;2478.913238036669;2340.8946597403155;2358.6697862299293;2376.691030166076;2475.8266921315517;2481.081999660128;2319.4665226997718;2336.030547322859;2345.812335013195;2346.507233480971;2441.072392490842;2340.414896275931;2351.4709190432186;2364.6689463475127;2364.7398786133513;2366.727826299963;10885.129189664807;11044.889551104467;11052.778944421067;11071.501782419811;11073.114150867992;5595.944040559623;5738.856528586777;5744.167095771131;5745.942540574624;5748.367679555246;3442.8106454145013;3491.4064609016527;3548.609652938175;3568.8215589220695;3569.8750543731103;1220.4568966809773;1243.247835059794;1247.2329517346857;1293.9482420703162;1353.4518519999417;14182;14467.348969296407;15715.292811823496;16246.918765406215;16406.83593164065;4448.332750087513;4616.0767846430845;4663.743494107856;4691.1555919934735;4697.271922851964;10730.141588672888;11038.17213708959;12316.199447035913;12337.259764414164;12351.073669474825;5713.6857472838565;5897.76408943646;5906.527477801851;5909.586328957018;5953.583249172603;5277;5403.432639572867;5462.7268636568015;5486.1770734389365;5494.066008778517;3951.229510245532;3996.5204175498543;4003.039270575041;4028.569857700533;4039.7172197946447;1001.9348742331725;1003.4982508745627;1028.9382637041801;1030.8093002794508;1036.4713995862014;973.7127547373542;1001.4742260313394;1004.6835246897203;1005.6379703306803;1025.487256371814;7168.390686791681;7406.592637404994;7410.555366678017;7428.73999410018;7429.62851857405;1077.1329080090445;1099.0987390340003;1112.0991996482874;1114.4929057278919;1146.8910453506903;4433.490148632948;4540.545945405433;4555.612772914273;4621.376114224537;4622.098690755338;13445.932770336085;13942.512012079529;13961.650958726113;13973.720525589431;13975.161490310615;13514.662133446742;13728.107673001223;13901.79147312791;13943.58169254924;13956.790648140286;10592.099671528007;10736.30214036085;10745.462726863781;10747.83878241827;10759.946200268949;6886.827829304308;6932.410745086724;7019.929800701928;7035.12060992376;7053.118360204974;13081.607551773463;13141.934290328487;13497.190168589916;13512.121712088683;13513.39189736484;12542.435590398272;13395.799063013868;13402.463901443833;13519.188848669111;13528.93235533816;9813.11681948628;9931.453770042428;10046.54790534413;10057.245706572183;10060.245481588763;10762.300450470695;10768.946155269174;10830.783384332426;10839.945800271264;10851.186161037796;9162.725118246462;9180.26557875355;9226.07739226072;9337.766555836159;9483.956764756009;8597.8710319344;8632.611532480927;8721.171488708562;8789.604467799092;8912;7837.921620783719;7923.603819809102;7928.088269849041;7928.881066784118;7943.84112317762;5721;5857.297124345106;5887.499562537061;5901.940980590139;6038.064100064497;5907.9704601476715;6001;6040.2147720797775;6138.294096178818;6168.167297414791 01:54:01 INFO - PROCESS | 25839 | |4;prototype.html;413.2912055824262;414;419.02367483762833;422.1599017954272;432.41407892305926;5308.469153084689;5331.786728530854;5341.599380046502;5351.117065684162;5367.3361258010045;5094.516020978011;5179.4561571035065;5234.947650523493;5279.604029697778;5281.762320695569;4315.633171180446;4324.632406245457;4328.285832837578;4333.978330108345;4336.97831510842;4335.414719012924;4346.804393802271;4348.847790327339;4350.956490435103;4354.433923589929;4258.403823464718;4303.225419424502;4445.977770111145;4448.955510444886;4471.79261599368;4439.955600444019;4444.933326000112;4454.708134640967;4466.955330446719;4494.7977341019405;4215.072684009513;4215.494140703136;4226.598473145046;4236.851710190129;4247.787610619456;4957.628177886673;5093.236014597803;5156.149235376159;5156.790270656995;5255.02781985334;5087;5111.422004596797;5132.871678208075;5138.460461651547;5142;5490.505854473076;5514.641548299348;5542.418046105182;5548.2536144608675;5593.216949627055;4320.481542214923;4587.174308624446;4591.494935557086;4607.769611519444;4630.560096790799;5491.890162196773;5637.900609381213;5771.220885180489;5787.305523337226;5793.623414478046;4560.977195114003;4588.311753236974;4592.770361481913;4631.536846315409;4674.686030414899;4783.497732738012;4808.471068182497;4844.95155048452;4858.489858564871;4864.829730959399;5020.6508104141685;5083.593312534988;5118.87202819925;5178.870528236749;5181.559567436735;5500.80747173847;5515;5521.254630624814;5533.557315414757;5542.365002324324;1627.1294857251314;1665.9416920407728;1672.356142884998;1672.9832701673072;1676.3881183368226;1230.7363533485882;1273.688101255708;1303.6284658872175;1310.7050913544376;1312.5930961401996;5330.974229792731;5548.639338442988;5552.361478429952;5583.609147359727;5587.7485513152005;5606.467385598362;5679.943200567942;5725.484706376363;5750.25246717924;5751.1883756616535;5479.753411096431;5484.533814625802;5494.340679118532;5497.39528651848;5506.146547285177;2921.5033444314518;2975.5536669499747;2979.851007449619;2997.685243049492;3036;5848.61983971049;5860.970695146582;5864.560157988168;5873.4126587340925;5886.499647530008;5436.945630543723;5768.250127483484;5772.989726797794;5790.276215473066;5818.883622327529;5845.970770146122;5905.409459054146;5917.230760001258;5918.348981612019;5945.940540594539;5756.625819321731;5775.5090817281;5778.479936805707;5807.041838096667;5814.244148260699;5508.20131080999;5590.832275031756;5592.790847615251;5668.914966275592;5704.458076482728;5632.295963004624;5706.828795136153;5728.3985181557;5854.970725146517;5863.413658634103;4700.177468942853;4748.216544270157;4770.809167633256;4772.761361931959;4787.18617834962;5395.433479484755;5644.068728659725;5658.943410565842;5703.602617358773;5741.196232527533;5514.696691681996;5551.389347171727;5569.1040658856355;5570.2480165177185;5577.498025177753;5489.670619762667;5505.449455054462;5658;5678.346990096026;5680.68756218412;5257.973710131425;5535.750891209825;5545.390007099135;5550.722463876709;5647.745851436613;5542.3903370630005;5592.7762889483965;5594.244776955059;5617.297837770278;5621.767483696973;5208.635395522277;5500.559955203654;5502.504774570308;5516.3380394352935;5520.86197845041 01:54:01 INFO - PROCESS | 25839 | |5;yui.html;824.86389745692;853.1894700034968;913.3560839608076;919.7240827751673;940.0693313619514;15344.386224551019;16861.66276674466;16880.746788798162;16885.577860553476;17427.390041348557;17164.71264655153;17293.82706172938;17375.652486950254;17408;17421.91289043556;851.586980314547;887.3344991256557;888.7422647432253;908.591133989704;913.3332667152982;889.4796544021755;889.8665200219954;890.9777255568598;892.8258989497051;893.1604291965564;943.4622265308777;944.4286206844863;944.8252073366415;944.9055094490565;945.2626950978248;935.9625614975461;936.2884208001899;936.7096200177966;937.1986951156799;937.3344925103185;691.3294104718415;691.8720036793159;692.304234244586;692.9341712537301;693.0435998322333;16634;16678.66642667152;16735.16324183798;17584.032878191694;17760.467185984442;15198.240087995557;15391.692166156727;15435.459758908384;15528.922355388151;15840;12686.238825670396;13203.207807531579;13211.537596184184;13280.601581952556;13337.399817008258;3962.40563915415;4053.756774593534;4056.229316429869;4083.8774836754646;4135.069609337905;49656.75171624119;51165.976680466185;68645;84240;91346;12456.875431245753;12606.747865042831;12642.620721378373;12682.80975785364;12783.424745886272;22700.65949010733;22996.19513317026;23049.308520744406;23199.072037118327;23231.88384058069;8617.61220745068;8625.0943650917;8843.646254149891;8861.867071993925;8929.598168082452;5113.8721531962;5155.61332900034;5194.740262986836;5292.364916210003;5394.460553944574;3609;3702.2225332680437;3706.054955986206;3707.629237076271;3707.9073023174637;585.6778771675562;588.9676067816312;596.9611975221596;598.1984141250745;598.6767145741251;808.4381354958248;820.306840719591;836.9539675317916;859.9097094804955;870.0342619692136;11288.379139147426;11510.53957841677;11637.101570973819;11868.762624747456;11899.286042837284;836.3601844588894;840.562907288219;840.7519781664423;848.5290663681593;850.1116333431579;5120.846374608767;5216.1393370094265;5218.425973142951;5219.973900130475;5241.344831896013;80016;80659.59670201612;81514;81665;83260.58369708234;45220.09559808851;56565.717171414704;57895;65406;73004.26995729975;59723;60363.698181508815;60405;60432.39567604267;60584.394156058755;11230.606928757454;11792;11820.527178913091;12064.215825971283;12099.33453660057;37571.81214093912;37769;38703;39358.60641393549;39838.60161398465;39906.80046599865;41496.792516037225;41834.163316734106;45648.54351456576;47059.29411058906;13705.794413083613;13785.310734463437;13809.585712428643;13917.304134793423;13976.091554048955;14853.183074930983;15012.774808377664;15309.311081001159;15325.233738312816;15376.38494460209;14864;15499.612509687347;15534.456294029655;16471.83528164703;16743;15659.843401565839;16118.516444506684;17004.65990680204;17216.91391543034;17248.655026899643;14976;15404.845951540341;15591.06453612787;15662.530124096294;15667.686646267239;10600;10982.505787239434;11414.315141091562;11530.654080377602;11841.46713397882;12667.80998285045;12804.167729097579;13451.932740336628;13625.86374136246;13745.862541374458 01:54:01 INFO - PROCESS | 25839 | __end_tp_report 01:54:01 INFO - PROCESS | 25839 | __start_cc_report 01:54:01 INFO - PROCESS | 25839 | _x_x_mozilla_cycle_collect,1437 01:54:01 INFO - PROCESS | 25839 | __end_cc_report 01:54:01 INFO - PROCESS | 25839 | __startTimestamp1493888041001__endTimestamp 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | ------- Summary: start ------- 01:54:01 INFO - PROCESS | 25839 | Number of tests: 6 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | [#0] dojo.html Cycles:165 Average:5826.79 Median:6051.36 stddev:652.23 (10.8%) stddev-sans-first:625.27 01:54:01 INFO - PROCESS | 25839 | Values: 3376.5 3483.2 3490.4 3510.8 3530.7 5825.8 5869.1 5914.8 5919.1 5936.3 5899.8 5940.4 5959.7 5960.6 5968.6 5373.2 5394.0 5423.5 5426.1 5455.6 5111.3 5119.9 5472.3 5491.9 5495.8 5303.9 5306.9 5426.7 5438.5 5450.3 5436.3 5446.5 5458.0 5458.3 5467.2 5115.2 5322.7 5364.5 5401.1 5466.9 5718.8 5728.1 5739.4 5750.0 5772.2 6266.8 6284.4 6287.7 6301.9 6302.6 6337.1 6347.0 6350.7 6351.9 6361.9 5651.5 5687.9 5780.3 5819.0 5823.0 6425.7 6426.1 6426.2 6429.6 6437.6 6104.4 6157.8 6195.7 6197.7 6201.6 6028.8 6058.3 6212.0 6243.6 6266.5 6302.7 6321.8 6325.7 6328.4 6328.5 5998.5 6038.6 6040.7 6134.4 6185.2 4760.1 4798.0 4813.7 4816.1 4831.3 4143.2 4143.5 4236.2 4285.7 4286.4 6048.4 6051.4 6086.8 6088.9 6098.2 6314.7 6338.3 6338.6 6349.7 6350.5 5780.9 5803.7 6020.9 6034.5 6044.9 5286.9 5292.3 5367.9 5373.1 5379.6 6483.2 6516.4 6525.1 6526.2 6533.6 5899.5 6275.6 6321.5 6325.7 6330.3 6178.0 6322.9 6399.7 6499.9 6518.4 6198.2 6205.1 6225.2 6226.5 6229.5 6258.5 6313.7 6316.9 6323.6 6325.5 5854.4 5909.5 6020.9 6059.6 6144.5 6135.8 6136.9 6146.1 6146.4 6148.1 5868.7 6121.6 6149.8 6163.6 6173.4 5950.2 6027.0 6068.4 6115.4 6177.5 6052.3 6068.7 6075.7 6077.5 6094.7 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | [#1] ext.html Cycles:180 Average:48487.93 Median:34461.66 stddev:82740.92 (240.1%) stddev-sans-first:82895.36 01:54:01 INFO - PROCESS | 25839 | Values: 739.8 794.1 812.9 878.6 895.4 31044.7 43307.8 44401.3 44428.8 44451.6 45758.5 45824.5 45882.5 46021.0 46142.0 7720.3 7869.3 9031.0 9168.0 9173.7 10496.2 10733.9 10734.1 10735.7 11052.9 10869.5 10924.0 10935.2 10938.8 10957.0 10729.3 10744.6 10819.2 10871.3 10879.6 10595.5 10639.8 10643.9 10644.9 10648.7 42441.0 42791.1 42846.6 42848.8 42879.8 4223.4 4264.1 4319.2 4407.5 4420.4 30010.0 30284.7 30520.8 31088.7 31844.5 4222.4 4390.6 4395.4 4426.6 4430.2 248539.0 249550.0 250099.0 250152.0 250180.0 46680.8 46867.3 47117.1 47145.0 47187.0 47825.5 48363.0 48397.3 48419.3 48548.0 15653.0 15957.7 16019.6 16022.0 16086.0 10749.6 10935.5 12162.8 13365.3 13447.9 13053.1 13119.7 13181.4 13202.3 13283.4 5361.1 5388.7 5506.3 5532.5 5553.3 1032.2 1046.5 1048.1 1269.8 1275.0 28277.6 30089.0 30165.2 30316.5 31263.8 1327.1 1333.4 1354.2 1356.9 1373.7 15204.9 15293.2 15314.5 15654.4 15686.6 347782.0 347857.0 348146.0 348719.0 351170.0 61527.0 61760.4 61953.4 61981.7 62156.7 1497.6 1519.5 1546.3 1555.9 1562.7 27396.6 28633.6 28792.0 28897.9 28991.9 45490.0 45648.1 45763.5 45768.5 45785.3 339199.0 339500.0 340245.0 341395.0 341468.0 30096.8 37653.4 38635.2 38774.2 38785.6 39993.6 45560.0 48712.3 49448.3 50150.0 34830.0 35458.3 35492.5 35857.0 35932.0 34940.5 35011.8 35248.3 35250.5 35259.5 40321.8 40431.8 40897.6 40980.8 41881.6 34039.7 34182.8 34338.0 34389.3 34534.0 26983.5 27570.9 27630.3 27752.3 27764.0 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | [#2] jquery.html Cycles:180 Average:36949.38 Median:13080.21 stddev:107531.50 (822.1%) stddev-sans-first:107798.24 01:54:01 INFO - PROCESS | 25839 | Values: 453.5 457.8 461.9 477.3 482.6 15327.3 15939.4 18998.8 20159.2 20845.8 20228.7 20291.2 20720.5 20943.2 20946.6 6270.6 6687.9 6714.9 6715.2 6716.2 6565.1 6680.0 6727.3 6750.1 6772.7 6736.7 6765.3 6767.0 6767.1 6772.1 6494.0 6594.0 6594.5 6621.0 6631.9 6463.0 6470.6 6478.6 6707.7 7009.8 23349.8 23502.6 23644.6 23771.2 23775.8 3060.5 3083.6 3090.8 3104.2 3111.1 15717.2 15745.7 15989.1 16135.2 16362.0 2266.4 2343.4 2384.7 2396.7 2411.2 81996.0 92316.1 107414.0 111878.0 112268.4 20810.5 20811.7 20823.9 20910.3 21593.2 42299.0 42522.4 42579.0 42721.0 43129.1 9709.9 10275.0 10319.6 10378.2 10485.5 9160.1 9170.8 9210.0 9409.9 9438.8 8906.9 9345.2 9385.7 9462.3 9469.5 3746.0 3938.4 3946.6 3984.7 4019.6 925.9 964.6 978.5 981.0 998.9 20476.0 20790.3 20829.5 20859.9 20916.9 937.1 959.7 960.4 961.8 977.6 11070.2 11372.8 11386.0 11443.1 11452.2 639776.0 646705.0 653838.0 660287.0 672979.0 84759.4 90572.5 97680.0 113005.0 116126.8 1237.0 1266.2 1280.7 1282.0 1291.7 18689.4 18932.0 19013.0 19088.9 19173.3 51043.0 51390.2 51396.0 53262.4 53671.7 67730.7 67877.0 68066.7 68496.3 68857.0 11565.1 11954.3 12062.8 12148.7 12150.2 13160.9 13486.0 13628.6 13685.2 13691.9 11152.9 11421.1 11758.8 11908.1 12527.2 10667.3 10899.0 11281.7 11408.9 11418.0 11893.3 11959.4 12042.6 12072.5 12134.8 12119.6 12392.1 12427.0 12467.3 12528.9 12201.6 12202.6 12340.3 12410.3 12414.5 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | [#3] mootools.html Cycles:180 Average:6949.65 Median:2364.70 stddev:4355.36 (184.2%) stddev-sans-first:4348.61 01:54:01 INFO - PROCESS | 25839 | Values: 1539.9 1573.9 1583.8 1585.7 1595.6 10533.7 11161.8 11164.5 11167.7 11179.4 10817.9 10941.2 11203.4 11521.0 11552.2 2437.3 2481.1 2481.7 2484.1 2485.7 2377.5 2424.2 2472.2 2474.0 2478.9 2340.9 2358.7 2376.7 2475.8 2481.1 2319.5 2336.0 2345.8 2346.5 2441.1 2340.4 2351.5 2364.7 2364.7 2366.7 10885.1 11044.9 11052.8 11071.5 11073.1 5595.9 5738.9 5744.2 5745.9 5748.4 3442.8 3491.4 3548.6 3568.8 3569.9 1220.5 1243.2 1247.2 1293.9 1353.5 14182.0 14467.3 15715.3 16246.9 16406.8 4448.3 4616.1 4663.7 4691.2 4697.3 10730.1 11038.2 12316.2 12337.3 12351.1 5713.7 5897.8 5906.5 5909.6 5953.6 5277.0 5403.4 5462.7 5486.2 5494.1 3951.2 3996.5 4003.0 4028.6 4039.7 1001.9 1003.5 1028.9 1030.8 1036.5 973.7 1001.5 1004.7 1005.6 1025.5 7168.4 7406.6 7410.6 7428.7 7429.6 1077.1 1099.1 1112.1 1114.5 1146.9 4433.5 4540.5 4555.6 4621.4 4622.1 13445.9 13942.5 13961.7 13973.7 13975.2 13514.7 13728.1 13901.8 13943.6 13956.8 10592.1 10736.3 10745.5 10747.8 10759.9 6886.8 6932.4 7019.9 7035.1 7053.1 13081.6 13141.9 13497.2 13512.1 13513.4 12542.4 13395.8 13402.5 13519.2 13528.9 9813.1 9931.5 10046.5 10057.2 10060.2 10762.3 10768.9 10830.8 10839.9 10851.2 9162.7 9180.3 9226.1 9337.8 9484.0 8597.9 8632.6 8721.2 8789.6 8912.0 7837.9 7923.6 7928.1 7928.9 7943.8 5721.0 5857.3 5887.5 5901.9 6038.1 5908.0 6001.0 6040.2 6138.3 6168.2 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | [#4] prototype.html Cycles:180 Average:4839.49 Median:5346.36 stddev:1290.20 (24.1%) stddev-sans-first:1250.31 01:54:01 INFO - PROCESS | 25839 | Values: 413.3 414.0 419.0 422.2 432.4 5308.5 5331.8 5341.6 5351.1 5367.3 5094.5 5179.5 5234.9 5279.6 5281.8 4315.6 4324.6 4328.3 4334.0 4337.0 4335.4 4346.8 4348.8 4351.0 4354.4 4258.4 4303.2 4446.0 4449.0 4471.8 4440.0 4444.9 4454.7 4467.0 4494.8 4215.1 4215.5 4226.6 4236.9 4247.8 4957.6 5093.2 5156.1 5156.8 5255.0 5087.0 5111.4 5132.9 5138.5 5142.0 5490.5 5514.6 5542.4 5548.3 5593.2 4320.5 4587.2 4591.5 4607.8 4630.6 5491.9 5637.9 5771.2 5787.3 5793.6 4561.0 4588.3 4592.8 4631.5 4674.7 4783.5 4808.5 4845.0 4858.5 4864.8 5020.7 5083.6 5118.9 5178.9 5181.6 5500.8 5515.0 5521.3 5533.6 5542.4 1627.1 1665.9 1672.4 1673.0 1676.4 1230.7 1273.7 1303.6 1310.7 1312.6 5331.0 5548.6 5552.4 5583.6 5587.7 5606.5 5679.9 5725.5 5750.3 5751.2 5479.8 5484.5 5494.3 5497.4 5506.1 2921.5 2975.6 2979.9 2997.7 3036.0 5848.6 5861.0 5864.6 5873.4 5886.5 5436.9 5768.3 5773.0 5790.3 5818.9 5846.0 5905.4 5917.2 5918.3 5945.9 5756.6 5775.5 5778.5 5807.0 5814.2 5508.2 5590.8 5592.8 5668.9 5704.5 5632.3 5706.8 5728.4 5855.0 5863.4 4700.2 4748.2 4770.8 4772.8 4787.2 5395.4 5644.1 5658.9 5703.6 5741.2 5514.7 5551.4 5569.1 5570.2 5577.5 5489.7 5505.4 5658.0 5678.3 5680.7 5258.0 5535.8 5545.4 5550.7 5647.7 5542.4 5592.8 5594.2 5617.3 5621.8 5208.6 5500.6 5502.5 5516.3 5520.9 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - PROCESS | 25839 | [#5] yui.html Cycles:180 Average:17415.88 Median:39872.70 stddev:20681.49 (51.9%) stddev-sans-first:20701.97 01:54:01 INFO - PROCESS | 25839 | Values: 824.9 853.2 913.4 919.7 940.1 15344.4 16861.7 16880.7 16885.6 17427.4 17164.7 17293.8 17375.7 17408.0 17421.9 851.6 887.3 888.7 908.6 913.3 889.5 889.9 891.0 892.8 893.2 943.5 944.4 944.8 944.9 945.3 936.0 936.3 936.7 937.2 937.3 691.3 691.9 692.3 692.9 693.0 16634.0 16678.7 16735.2 17584.0 17760.5 15198.2 15391.7 15435.5 15528.9 15840.0 12686.2 13203.2 13211.5 13280.6 13337.4 3962.4 4053.8 4056.2 4083.9 4135.1 49656.8 51166.0 68645.0 84240.0 91346.0 12456.9 12606.7 12642.6 12682.8 12783.4 22700.7 22996.2 23049.3 23199.1 23231.9 8617.6 8625.1 8843.6 8861.9 8929.6 5113.9 5155.6 5194.7 5292.4 5394.5 3609.0 3702.2 3706.1 3707.6 3707.9 585.7 589.0 597.0 598.2 598.7 808.4 820.3 837.0 859.9 870.0 11288.4 11510.5 11637.1 11868.8 11899.3 836.4 840.6 840.8 848.5 850.1 5120.8 5216.1 5218.4 5220.0 5241.3 80016.0 80659.6 81514.0 81665.0 83260.6 45220.1 56565.7 57895.0 65406.0 73004.3 59723.0 60363.7 60405.0 60432.4 60584.4 11230.6 11792.0 11820.5 12064.2 12099.3 37571.8 37769.0 38703.0 39358.6 39838.6 39906.8 41496.8 41834.2 45648.5 47059.3 13705.8 13785.3 13809.6 13917.3 13976.1 14853.2 15012.8 15309.3 15325.2 15376.4 14864.0 15499.6 15534.5 16471.8 16743.0 15659.8 16118.5 17004.7 17216.9 17248.7 14976.0 15404.8 15591.1 15662.5 15667.7 10600.0 10982.5 11414.3 11530.7 11841.5 12667.8 12804.2 13451.9 13625.9 13745.9 01:54:01 INFO - PROCESS | 25839 | -------- Summary: end -------- 01:54:01 INFO - PROCESS | 25839 | 01:54:01 INFO - TEST-INFO | 25839: exit 0 01:54:01 INFO - TEST-OK | dromaeo_css | took 1115834ms 01:54:01 INFO - TEST-START | kraken 01:54:01 INFO - operating with platform_type : linux_ 01:54:01 INFO - Initialising browser for kraken test... 01:54:01 INFO - TEST-INFO | started process 26171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoR6u_g/profile http://localhost:33543/getInfo.html) 01:54:05 INFO - PROCESS | 26171 | __metrics Screen width/height:1600/1200 01:54:05 INFO - PROCESS | 26171 | colorDepth:24 01:54:05 INFO - PROCESS | 26171 | Browser inner width/height: 1024/697 01:54:05 INFO - PROCESS | 26171 | __metrics 01:54:06 INFO - PROCESS | 26171 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:54:06 INFO - PROCESS | 26171 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:54:06 INFO - PROCESS | 26171 | console.error: PushService: 01:54:06 INFO - PROCESS | 26171 | stateChangeProcessEnqueue: Error transitioning state 01:54:06 INFO - PROCESS | 26171 | UnknownError 01:54:07 INFO - TEST-INFO | 26171: exit 0 01:54:07 INFO - Browser initialized. 01:54:07 INFO - Running cycle 1/1 for kraken test... 01:54:07 INFO - TEST-INFO | started process 26263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoR6u_g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:19 INFO - PROCESS | 26263 | RSS: Main: 139595776 01:54:19 INFO - PROCESS | 26263 | 01:54:21 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-beat-detection) 01:54:22 INFO - PROCESS | 26263 | RSS: Main: 182771712 01:54:22 INFO - PROCESS | 26263 | 01:54:25 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-dft) 01:54:25 INFO - PROCESS | 26263 | RSS: Main: 173899776 01:54:25 INFO - PROCESS | 26263 | 01:54:28 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-fft) 01:54:29 INFO - PROCESS | 26263 | RSS: Main: 265846784 01:54:29 INFO - PROCESS | 26263 | 01:54:31 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-oscillator) 01:54:31 INFO - PROCESS | 26263 | RSS: Main: 172109824 01:54:31 INFO - PROCESS | 26263 | 01:54:33 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:34 INFO - PROCESS | 26263 | RSS: Main: 174264320 01:54:34 INFO - PROCESS | 26263 | 01:54:37 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33543/tests/kraken/driver.html?testName=imaging-darkroom) 01:54:38 INFO - PROCESS | 26263 | RSS: Main: 212889600 01:54:38 INFO - PROCESS | 26263 | 01:54:41 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33543/tests/kraken/driver.html?testName=imaging-desaturate) 01:54:42 INFO - PROCESS | 26263 | RSS: Main: 211988480 01:54:42 INFO - PROCESS | 26263 | 01:54:44 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33543/tests/kraken/driver.html?testName=json-parse-financial) 01:54:45 INFO - PROCESS | 26263 | RSS: Main: 210640896 01:54:45 INFO - PROCESS | 26263 | 01:54:46 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:54:47 INFO - PROCESS | 26263 | RSS: Main: 172990464 01:54:47 INFO - PROCESS | 26263 | 01:54:49 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:54:49 INFO - PROCESS | 26263 | RSS: Main: 179154944 01:54:49 INFO - PROCESS | 26263 | 01:54:51 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:54:52 INFO - PROCESS | 26263 | RSS: Main: 189210624 01:54:52 INFO - PROCESS | 26263 | 01:54:55 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:54:55 INFO - PROCESS | 26263 | RSS: Main: 197857280 01:54:55 INFO - PROCESS | 26263 | 01:54:58 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:54:59 INFO - PROCESS | 26263 | RSS: Main: 195096576 01:54:59 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33543/tests/kraken/driver.html?testName=ai-astar) 01:55:00 INFO - PROCESS | 26263 | RSS: Main: 246546432 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | __start_tp_report 01:55:00 INFO - PROCESS | 26263 | _x_x_mozilla_page_load 01:55:00 INFO - PROCESS | 26263 | _x_x_mozilla_page_load_details 01:55:00 INFO - PROCESS | 26263 | |i|pagename|runs| 01:55:00 INFO - PROCESS | 26263 | |0;ai-astar;101;113;111;112;111;113;113;112;112;114 01:55:00 INFO - PROCESS | 26263 | |1;audio-beat-detection;146;121;121;151;121;118;116;115;143;117 01:55:00 INFO - PROCESS | 26263 | |2;audio-dft;162;160;162;162;161;160;162;161;160;161 01:55:00 INFO - PROCESS | 26263 | |3;audio-fft;75;75;76;109;75;76;75;76;93;75 01:55:00 INFO - PROCESS | 26263 | |4;audio-oscillator;82;82;110;83;83;83;96;83;83;109 01:55:00 INFO - PROCESS | 26263 | |5;imaging-gaussian-blur;113;113;113;113;113;113;114;113;113;113 01:55:00 INFO - PROCESS | 26263 | |6;imaging-darkroom;147;146;146;146;147;148;146;146;146;146 01:55:00 INFO - PROCESS | 26263 | |7;imaging-desaturate;95;93;95;94;95;93;93;94;93;93 01:55:00 INFO - PROCESS | 26263 | |8;json-parse-financial;54;55;54;54;56;55;55;53;55;53 01:55:00 INFO - PROCESS | 26263 | |9;json-stringify-tinderbox;54;54;54;54;53;53;54;54;54;54 01:55:00 INFO - PROCESS | 26263 | |10;stanford-crypto-aes;76;76;76;80;75;84;79;81;83;77 01:55:00 INFO - PROCESS | 26263 | |11;stanford-crypto-ccm;127;119;131;129;128;126;130;122;159;131 01:55:00 INFO - PROCESS | 26263 | |12;stanford-crypto-pbkdf2;165;167;161;157;163;158;163;156;166;162 01:55:00 INFO - PROCESS | 26263 | |13;stanford-crypto-sha256-iterative;60;59;60;61;59;60;60;60;59;59 01:55:00 INFO - PROCESS | 26263 | __end_tp_report 01:55:00 INFO - PROCESS | 26263 | __start_cc_report 01:55:00 INFO - PROCESS | 26263 | _x_x_mozilla_cycle_collect,1665 01:55:00 INFO - PROCESS | 26263 | __end_cc_report 01:55:00 INFO - PROCESS | 26263 | __startTimestamp1493888100966__endTimestamp 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | ------- Summary: start ------- 01:55:00 INFO - PROCESS | 26263 | Number of tests: 14 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.71 (3.3%) stddev-sans-first:1.00 01:55:00 INFO - PROCESS | 26263 | Values: 101.0 113.0 111.0 112.0 111.0 113.0 113.0 112.0 112.0 114.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:121.00 stddev:13.93 (11.5%) stddev-sans-first:12.95 01:55:00 INFO - PROCESS | 26263 | Values: 146.0 121.0 121.0 151.0 121.0 118.0 116.0 115.0 143.0 117.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 01:55:00 INFO - PROCESS | 26263 | Values: 162.0 160.0 162.0 162.0 161.0 160.0 162.0 161.0 160.0 161.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.50 stddev:11.45 (15.2%) stddev-sans-first:11.97 01:55:00 INFO - PROCESS | 26263 | Values: 75.0 75.0 76.0 109.0 75.0 76.0 75.0 76.0 93.0 75.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:83.00 stddev:11.38 (13.7%) stddev-sans-first:11.76 01:55:00 INFO - PROCESS | 26263 | Values: 82.0 82.0 110.0 83.0 83.0 83.0 96.0 83.0 83.0 109.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:55:00 INFO - PROCESS | 26263 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 01:55:00 INFO - PROCESS | 26263 | Values: 147.0 146.0 146.0 146.0 147.0 148.0 146.0 146.0 146.0 146.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 01:55:00 INFO - PROCESS | 26263 | Values: 95.0 93.0 95.0 94.0 95.0 93.0 93.0 94.0 93.0 93.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 01:55:00 INFO - PROCESS | 26263 | Values: 54.0 55.0 54.0 54.0 56.0 55.0 55.0 53.0 55.0 53.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 01:55:00 INFO - PROCESS | 26263 | Values: 54.0 54.0 54.0 54.0 53.0 53.0 54.0 54.0 54.0 54.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.50 stddev:3.20 (4.0%) stddev-sans-first:3.24 01:55:00 INFO - PROCESS | 26263 | Values: 76.0 76.0 76.0 80.0 75.0 84.0 79.0 81.0 83.0 77.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:129.50 stddev:10.84 (8.4%) stddev-sans-first:11.44 01:55:00 INFO - PROCESS | 26263 | Values: 127.0 119.0 131.0 129.0 128.0 126.0 130.0 122.0 159.0 131.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:163.00 stddev:3.79 (2.3%) stddev-sans-first:3.84 01:55:00 INFO - PROCESS | 26263 | Values: 165.0 167.0 161.0 157.0 163.0 158.0 163.0 156.0 166.0 162.0 01:55:00 INFO - PROCESS | 26263 | 01:55:00 INFO - PROCESS | 26263 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 01:55:00 INFO - PROCESS | 26263 | Values: 60.0 59.0 60.0 61.0 59.0 60.0 60.0 60.0 59.0 59.0 01:55:00 INFO - PROCESS | 26263 | -------- Summary: end -------- 01:55:00 INFO - PROCESS | 26263 | 01:55:02 INFO - TEST-INFO | 26263: exit 0 01:55:02 INFO - TEST-OK | kraken | took 60262ms 01:55:02 INFO - SUITE-END | took 1176s 01:55:02 INFO - Completed test suite (00:19:36) 01:55:02 INFO - javascript benchmark 01:55:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7860.86788896449, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.5272861799344, 3483.1640406302495, 3490.4066308727506, 3510.7893526388434, 3530.6645868642486, 5825.766969321227, 5869.060950247961, 5914.763409463616, 5919.112133180025, 5936.3470018298, 5899.793507227248, 5940.37626049264, 5959.672218028007, 5960.5529585281065, 5968.582199246054, 5373.247745315659, 5393.973030134844, 5423.511883930445, 5426.104692725696, 5455.563554915617, 5111.258867464216, 5119.923201151985, 5472.26124473195, 5491.862703432426, 5495.8351249462385, 5303.946960530384, 5306.946930530684, 5426.701531415771, 5438.456154384569, 5450.264214331074, 5436.3476382834315, 5446.455354464521, 5457.972710136443, 5458.263134476854, 5467.152591348347, 5115.2071428928575, 5322.7072511011875, 5364.544013758835, 5401.054815407288, 5466.945330546683, 5718.799842005551, 5728.112142617901, 5739.397363276879, 5750.0, 5772.191893134965, 6266.78066267683, 6284.402981716729, 6287.6856157192415, 6301.87396252077, 6302.590331628429, 6337.081123237151, 6346.968265158691, 6350.745970161188, 6351.9364806351805, 6361.872762544724, 5651.4913657770585, 5687.943120568782, 5780.335261444946, 5819.039858423397, 5823.0, 6425.710843011982, 6426.132472116298, 6426.228852537725, 6429.646369449725, 6437.613743175424, 6104.389561043949, 6157.815265542041, 6195.721192546346, 6197.659128747962, 6201.596896201732, 6028.758849645965, 6058.333583305833, 6212.0371342441995, 6243.594166379171, 6266.467350275187, 6302.716377763011, 6321.841953951096, 6325.746970121144, 6328.398802113792, 6328.46208072319, 5998.4601385875485, 6038.607490513103, 6040.6677632730625, 6134.387509608313, 6185.226846644169, 4760.09558183944, 4797.952020479751, 4813.687110337817, 4816.109019831342, 4831.299461578052, 4143.19207754485, 4143.461350024538, 4236.173946080485, 4285.7000009999, 4286.442762440863, 6048.395160483917, 6051.364606716319, 6086.756529738849, 6088.908666370008, 6098.207233059674, 6314.652694101776, 6338.30278669346, 6338.58799178052, 6349.746010159542, 6350.460210882126, 5780.942190578125, 5803.7388317524965, 6020.879582408327, 6034.456898879122, 6044.909326360108, 5286.894262114736, 5292.311999440049, 5367.946320536823, 5373.11343628297, 5379.569634429236, 6483.157189565326, 6516.446102081281, 6525.119108920235, 6526.184226971629, 6533.575317604341, 5899.528037757055, 6275.592086514362, 6321.494280457644, 6325.652089135142, 6330.303666596763, 6178.0, 6322.8735425290315, 6399.7440102395385, 6499.870002600016, 6518.380753828379, 6198.2252218472695, 6205.069239614094, 6225.221847269091, 6226.533010024175, 6229.501639868709, 6258.530610204162, 6313.6843157841, 6316.905246421215, 6323.620582765049, 6325.462335701332, 5854.356020837789, 5909.468147866713, 6020.939790602038, 6059.606125601822, 6144.525313924715, 6135.808695391702, 6136.938630613815, 6146.108814222002, 6146.446819786241, 6148.1085242640465, 5868.706564671835, 6121.575768430891, 6149.84625384369, 6163.599366041193, 6173.41352571505, 5950.16697662319, 6027.0, 6068.393160684073, 6115.388461153849, 6177.536684748572, 6052.273727152769, 6068.696565171812, 6075.726592303268, 6077.453029227214, 6094.695265236809], "value": 5783.89046069519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7595781371052, 794.1462927353095, 812.8983877015371, 878.617801256453, 895.4492986813112, 31044.68955310446, 43307.78346108269, 44401.333979990326, 44428.777856110675, 44451.55548444515, 45758.542414575844, 45824.541754582446, 45882.541174588245, 46021.0, 46142.0, 7720.266574675396, 7869.291763741262, 9031.0, 9168.0, 9173.724788256362, 10496.160307175445, 10733.892661073367, 10734.087602553793, 10735.677929662123, 11052.889471105267, 10869.510872010778, 10924.0, 10935.179861510378, 10938.835917461245, 10957.0, 10729.302595331317, 10744.570217191304, 10819.188560857967, 10871.347719136877, 10879.564817407294, 10595.523201455875, 10639.787204255948, 10643.94678026605, 10644.893551064468, 10648.680539583826, 42441.0, 42791.14417711659, 42846.57153428457, 42848.78575607133, 42879.78560107211, 4223.408722778813, 4264.0619063806225, 4319.200947824663, 4407.471103467605, 4420.381146639473, 30010.0, 30284.69715302863, 30520.8473957631, 31088.68911310903, 31844.522332165037, 4222.4299719538085, 4390.626796722282, 4395.362672412482, 4426.579474949875, 4430.180416622935, 248539.0, 249550.0, 250099.0, 250152.0, 250180.0, 46680.7665961668, 46867.29699054517, 47117.05765884732, 47145.0, 47187.0, 47825.5217447828, 48363.0, 48397.27404088942, 48419.27371089436, 48548.029039419016, 15653.0, 15957.680846383008, 16019.599510012109, 16022.038677679377, 16086.0, 10749.623763168407, 10935.507902144423, 12162.817557736642, 13365.33173341329, 13447.865521344662, 13053.086283960032, 13119.672008199681, 13181.406836692371, 13202.33988300581, 13283.402246898913, 5361.0618141825025, 5388.703621300788, 5506.256655351556, 5532.486870836967, 5553.305836770403, 1032.1845741863845, 1046.5081411736471, 1048.051513380392, 1269.752398282326, 1274.961751147467, 28277.57583636247, 30089.0, 30165.245868853453, 30316.54525182124, 31263.84368078145, 1327.0680060131199, 1333.3733145421636, 1354.2483921423704, 1356.8846648035028, 1373.7458570164551, 15204.923975380274, 15293.158876261912, 15314.540563783105, 15654.373825047098, 15686.607834803994, 347782.0, 347857.0, 348146.0, 348719.0, 351170.0, 61527.0, 61760.38239617636, 61953.38046619476, 61981.69009154925, 62156.68921655363, 1497.5956491747386, 1519.5289460267131, 1546.3350759173438, 1555.8599726024713, 1562.7265228584952, 27396.58905116385, 28633.570496442153, 28792.0, 28897.85551072231, 28991.855040724662, 45490.0, 45648.08703825971, 45763.54236457726, 45768.54231457643, 45785.313220302385, 339199.0, 339500.0, 340245.0, 341395.0, 341468.0, 30096.84951575228, 37653.435198471496, 38635.2272954545, 38774.2245155101, 38785.6121438782, 39993.60006400015, 45560.0, 48712.269315961, 49448.25827612517, 50150.0, 34830.0, 35458.29083418369, 35492.467612986344, 35857.0, 35932.0, 34940.47589286214, 35011.82494087513, 35248.295034098664, 35250.471242930864, 35259.47110793289, 40321.798391007855, 40431.79784101179, 40897.59102408938, 40980.79509602433, 41881.581184187766, 34039.65960340464, 34182.82908585441, 34338.0, 34389.312213756086, 34534.0, 26983.460330793667, 27570.893739047922, 27630.309242269104, 27752.306192345353, 27764.0], "value": 19564.792584819363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.4830293465448, 457.81197791730466, 461.9236531789604, 477.31981925755787, 482.6066755594191, 15327.310271037803, 15939.362425502966, 18998.810011899877, 20159.19363225471, 20845.791542084593, 20228.69656955147, 20291.18835246592, 20720.48198795031, 20943.16227350908, 20946.581068378662, 6270.5924114932495, 6687.866242675143, 6714.865702685944, 6715.194176698803, 6716.2276338221, 6565.146530950994, 6680.0, 6727.260001399842, 6750.122484077063, 6772.695228714695, 6736.696848641823, 6765.289644587321, 6766.966165169168, 6767.052612634235, 6772.051912732221, 6493.967530162343, 6594.0, 6594.505412094112, 6621.0, 6631.900521492182, 6463.0, 6470.644114573696, 6478.643674597895, 6707.6981535831, 7009.82475438113, 23349.76650233493, 23502.64746028811, 23644.645330320058, 23771.16800911977, 23775.76224237753, 3060.525618529109, 3083.5683004379407, 3090.8145511269395, 3104.239461331988, 3111.0511294055304, 15717.214139293104, 15745.68508629821, 15989.120598367084, 16135.193240337936, 16362.018278903184, 2266.422062374084, 2343.414146463384, 2384.666146739458, 2396.748341424143, 2411.2043025801445, 81996.0, 92316.07683923209, 107414.0, 111878.0, 112268.43865780701, 20810.47973800637, 20811.68782468264, 20823.8958805205, 20910.268140615004, 21593.24423645165, 42299.0, 42522.36216456756, 42579.0, 42721.0, 43129.13741725148, 9709.854352184722, 10275.02387273208, 10319.638812641522, 10378.169746420268, 10485.475726213659, 9160.083991600786, 9170.81658366829, 9209.953950230207, 9409.905900940903, 9438.764030899145, 8906.886639170103, 9345.215187848931, 9385.671501497414, 9462.29032822541, 9469.479178645102, 3745.962540374616, 3938.448617193595, 3946.605339466088, 3984.6812255019527, 4019.577944315863, 925.8981512033671, 964.6382606522554, 978.5205249427729, 980.9902148953854, 998.8951160128228, 20476.0, 20790.272340468313, 20829.479263018547, 20859.8957005214, 20916.895415522824, 937.1331518345503, 959.7216807125856, 960.4237457525569, 961.8268711631973, 977.628501169551, 11070.169737269736, 11372.829407558893, 11385.975262226273, 11443.084553235722, 11452.198346115692, 639776.0, 646705.0, 653838.0, 660287.0, 672979.0, 84759.37290367413, 90572.54713726521, 97680.0, 113005.0, 116126.83873161329, 1236.9876301237052, 1266.1516783754905, 1280.7118398360294, 1281.9743605128033, 1291.735194285188, 18689.439316819975, 18932.0, 19013.0, 19088.904555477133, 19173.32893348726, 51043.0, 51390.22914656358, 51396.0, 53262.42340027704, 53671.73164134155, 67730.66134669296, 67877.0, 68066.65966670135, 68496.26014959546, 68857.0, 11565.074794016291, 11954.282743035446, 12062.75874482488, 12148.696282593006, 12150.21023633461, 13160.868391316348, 13486.0, 13628.591142265748, 13685.247311397969, 13691.931540342235, 11152.888471115184, 11421.1434142438, 11758.82361764557, 11908.106891982963, 12527.18573292733, 10667.306625069346, 10899.0, 11281.71795705114, 11408.885911140782, 11418.0, 11893.345865977108, 11959.402029898296, 12042.63872083839, 12072.517099315928, 12134.75730485403, 12119.575814846437, 12392.070594705252, 12427.0, 12467.316912216735, 12528.87471125277, 12201.572944946884, 12202.633920982385, 12340.3212823292, 12410.317432540936, 12414.503419863104], "value": 11352.850370499145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.9230038498072, 1573.8819588530855, 1583.8336974617657, 1585.6749366379893, 1595.633004408986, 10533.683989480309, 11161.776764464716, 11164.497597608106, 11167.664970050891, 11179.385133817637, 10817.945910270457, 10941.179411544146, 11203.439828008588, 11521.0, 11552.191346605741, 2437.305367970129, 2481.10680155144, 2481.702195736514, 2484.1057219401, 2485.7141428735745, 2377.4769550698907, 2424.200013995386, 2472.208893154191, 2474.0, 2478.913238036669, 2340.8946597403155, 2358.6697862299293, 2376.691030166076, 2475.8266921315517, 2481.081999660128, 2319.4665226997718, 2336.030547322859, 2345.812335013195, 2346.507233480971, 2441.072392490842, 2340.414896275931, 2351.4709190432186, 2364.6689463475127, 2364.7398786133513, 2366.727826299963, 10885.129189664807, 11044.889551104467, 11052.778944421067, 11071.501782419811, 11073.114150867992, 5595.944040559623, 5738.856528586777, 5744.167095771131, 5745.942540574624, 5748.367679555246, 3442.8106454145013, 3491.4064609016527, 3548.609652938175, 3568.8215589220695, 3569.8750543731103, 1220.4568966809773, 1243.247835059794, 1247.2329517346857, 1293.9482420703162, 1353.4518519999417, 14182.0, 14467.348969296407, 15715.292811823496, 16246.918765406215, 16406.83593164065, 4448.332750087513, 4616.0767846430845, 4663.743494107856, 4691.1555919934735, 4697.271922851964, 10730.141588672888, 11038.17213708959, 12316.199447035913, 12337.259764414164, 12351.073669474825, 5713.6857472838565, 5897.76408943646, 5906.527477801851, 5909.586328957018, 5953.583249172603, 5277.0, 5403.432639572867, 5462.7268636568015, 5486.1770734389365, 5494.066008778517, 3951.229510245532, 3996.5204175498543, 4003.039270575041, 4028.569857700533, 4039.7172197946447, 1001.9348742331725, 1003.4982508745627, 1028.9382637041801, 1030.8093002794508, 1036.4713995862014, 973.7127547373542, 1001.4742260313394, 1004.6835246897203, 1005.6379703306803, 1025.487256371814, 7168.390686791681, 7406.592637404994, 7410.555366678017, 7428.73999410018, 7429.62851857405, 1077.1329080090445, 1099.0987390340003, 1112.0991996482874, 1114.4929057278919, 1146.8910453506903, 4433.490148632948, 4540.545945405433, 4555.612772914273, 4621.376114224537, 4622.098690755338, 13445.932770336085, 13942.512012079529, 13961.650958726113, 13973.720525589431, 13975.161490310615, 13514.662133446742, 13728.107673001223, 13901.79147312791, 13943.58169254924, 13956.790648140286, 10592.099671528007, 10736.30214036085, 10745.462726863781, 10747.83878241827, 10759.946200268949, 6886.827829304308, 6932.410745086724, 7019.929800701928, 7035.12060992376, 7053.118360204974, 13081.607551773463, 13141.934290328487, 13497.190168589916, 13512.121712088683, 13513.39189736484, 12542.435590398272, 13395.799063013868, 13402.463901443833, 13519.188848669111, 13528.93235533816, 9813.11681948628, 9931.453770042428, 10046.54790534413, 10057.245706572183, 10060.245481588763, 10762.300450470695, 10768.946155269174, 10830.783384332426, 10839.945800271264, 10851.186161037796, 9162.725118246462, 9180.26557875355, 9226.07739226072, 9337.766555836159, 9483.956764756009, 8597.8710319344, 8632.611532480927, 8721.171488708562, 8789.604467799092, 8912.0, 7837.921620783719, 7923.603819809102, 7928.088269849041, 7928.881066784118, 7943.84112317762, 5721.0, 5857.297124345106, 5887.499562537061, 5901.940980590139, 6038.064100064497, 5907.9704601476715, 6001.0, 6040.2147720797775, 6138.294096178818, 6168.167297414791], "value": 5293.8538195832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.2912055824262, 414.0, 419.02367483762833, 422.1599017954272, 432.41407892305926, 5308.469153084689, 5331.786728530854, 5341.599380046502, 5351.117065684162, 5367.3361258010045, 5094.516020978011, 5179.4561571035065, 5234.947650523493, 5279.604029697778, 5281.762320695569, 4315.633171180446, 4324.632406245457, 4328.285832837578, 4333.978330108345, 4336.97831510842, 4335.414719012924, 4346.804393802271, 4348.847790327339, 4350.956490435103, 4354.433923589929, 4258.403823464718, 4303.225419424502, 4445.977770111145, 4448.955510444886, 4471.79261599368, 4439.955600444019, 4444.933326000112, 4454.708134640967, 4466.955330446719, 4494.7977341019405, 4215.072684009513, 4215.494140703136, 4226.598473145046, 4236.851710190129, 4247.787610619456, 4957.628177886673, 5093.236014597803, 5156.149235376159, 5156.790270656995, 5255.02781985334, 5087.0, 5111.422004596797, 5132.871678208075, 5138.460461651547, 5142.0, 5490.505854473076, 5514.641548299348, 5542.418046105182, 5548.2536144608675, 5593.216949627055, 4320.481542214923, 4587.174308624446, 4591.494935557086, 4607.769611519444, 4630.560096790799, 5491.890162196773, 5637.900609381213, 5771.220885180489, 5787.305523337226, 5793.623414478046, 4560.977195114003, 4588.311753236974, 4592.770361481913, 4631.536846315409, 4674.686030414899, 4783.497732738012, 4808.471068182497, 4844.95155048452, 4858.489858564871, 4864.829730959399, 5020.6508104141685, 5083.593312534988, 5118.87202819925, 5178.870528236749, 5181.559567436735, 5500.80747173847, 5515.0, 5521.254630624814, 5533.557315414757, 5542.365002324324, 1627.1294857251314, 1665.9416920407728, 1672.356142884998, 1672.9832701673072, 1676.3881183368226, 1230.7363533485882, 1273.688101255708, 1303.6284658872175, 1310.7050913544376, 1312.5930961401996, 5330.974229792731, 5548.639338442988, 5552.361478429952, 5583.609147359727, 5587.7485513152005, 5606.467385598362, 5679.943200567942, 5725.484706376363, 5750.25246717924, 5751.1883756616535, 5479.753411096431, 5484.533814625802, 5494.340679118532, 5497.39528651848, 5506.146547285177, 2921.5033444314518, 2975.5536669499747, 2979.851007449619, 2997.685243049492, 3036.0, 5848.61983971049, 5860.970695146582, 5864.560157988168, 5873.4126587340925, 5886.499647530008, 5436.945630543723, 5768.250127483484, 5772.989726797794, 5790.276215473066, 5818.883622327529, 5845.970770146122, 5905.409459054146, 5917.230760001258, 5918.348981612019, 5945.940540594539, 5756.625819321731, 5775.5090817281, 5778.479936805707, 5807.041838096667, 5814.244148260699, 5508.20131080999, 5590.832275031756, 5592.790847615251, 5668.914966275592, 5704.458076482728, 5632.295963004624, 5706.828795136153, 5728.3985181557, 5854.970725146517, 5863.413658634103, 4700.177468942853, 4748.216544270157, 4770.809167633256, 4772.761361931959, 4787.18617834962, 5395.433479484755, 5644.068728659725, 5658.943410565842, 5703.602617358773, 5741.196232527533, 5514.696691681996, 5551.389347171727, 5569.1040658856355, 5570.2480165177185, 5577.498025177753, 5489.670619762667, 5505.449455054462, 5658.0, 5678.346990096026, 5680.68756218412, 5257.973710131425, 5535.750891209825, 5545.390007099135, 5550.722463876709, 5647.745851436613, 5542.3903370630005, 5592.7762889483965, 5594.244776955059, 5617.297837770278, 5621.767483696973, 5208.635395522277, 5500.559955203654, 5502.504774570308, 5516.3380394352935, 5520.86197845041], "value": 4464.851817997144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.86389745692, 853.1894700034968, 913.3560839608076, 919.7240827751673, 940.0693313619514, 15344.386224551019, 16861.66276674466, 16880.746788798162, 16885.577860553476, 17427.390041348557, 17164.71264655153, 17293.82706172938, 17375.652486950254, 17408.0, 17421.91289043556, 851.586980314547, 887.3344991256557, 888.7422647432253, 908.591133989704, 913.3332667152982, 889.4796544021755, 889.8665200219954, 890.9777255568598, 892.8258989497051, 893.1604291965564, 943.4622265308777, 944.4286206844863, 944.8252073366415, 944.9055094490565, 945.2626950978248, 935.9625614975461, 936.2884208001899, 936.7096200177966, 937.1986951156799, 937.3344925103185, 691.3294104718415, 691.8720036793159, 692.304234244586, 692.9341712537301, 693.0435998322333, 16634.0, 16678.66642667152, 16735.16324183798, 17584.032878191694, 17760.467185984442, 15198.240087995557, 15391.692166156727, 15435.459758908384, 15528.922355388151, 15840.0, 12686.238825670396, 13203.207807531579, 13211.537596184184, 13280.601581952556, 13337.399817008258, 3962.40563915415, 4053.756774593534, 4056.229316429869, 4083.8774836754646, 4135.069609337905, 49656.75171624119, 51165.976680466185, 68645.0, 84240.0, 91346.0, 12456.875431245753, 12606.747865042831, 12642.620721378373, 12682.80975785364, 12783.424745886272, 22700.65949010733, 22996.19513317026, 23049.308520744406, 23199.072037118327, 23231.88384058069, 8617.61220745068, 8625.0943650917, 8843.646254149891, 8861.867071993925, 8929.598168082452, 5113.8721531962, 5155.61332900034, 5194.740262986836, 5292.364916210003, 5394.460553944574, 3609.0, 3702.2225332680437, 3706.054955986206, 3707.629237076271, 3707.9073023174637, 585.6778771675562, 588.9676067816312, 596.9611975221596, 598.1984141250745, 598.6767145741251, 808.4381354958248, 820.306840719591, 836.9539675317916, 859.9097094804955, 870.0342619692136, 11288.379139147426, 11510.53957841677, 11637.101570973819, 11868.762624747456, 11899.286042837284, 836.3601844588894, 840.562907288219, 840.7519781664423, 848.5290663681593, 850.1116333431579, 5120.846374608767, 5216.1393370094265, 5218.425973142951, 5219.973900130475, 5241.344831896013, 80016.0, 80659.59670201612, 81514.0, 81665.0, 83260.58369708234, 45220.09559808851, 56565.717171414704, 57895.0, 65406.0, 73004.26995729975, 59723.0, 60363.698181508815, 60405.0, 60432.39567604267, 60584.394156058755, 11230.606928757454, 11792.0, 11820.527178913091, 12064.215825971283, 12099.33453660057, 37571.81214093912, 37769.0, 38703.0, 39358.60641393549, 39838.60161398465, 39906.80046599865, 41496.792516037225, 41834.163316734106, 45648.54351456576, 47059.29411058906, 13705.794413083613, 13785.310734463437, 13809.585712428643, 13917.304134793423, 13976.091554048955, 14853.183074930983, 15012.774808377664, 15309.311081001159, 15325.233738312816, 15376.38494460209, 14864.0, 15499.612509687347, 15534.456294029655, 16471.83528164703, 16743.0, 15659.843401565839, 16118.516444506684, 17004.65990680204, 17216.91391543034, 17248.655026899643, 14976.0, 15404.845951540341, 15591.06453612787, 15662.530124096294, 15667.686646267239, 10600.0, 10982.505787239434, 11414.315141091562, 11530.654080377602, 11841.46713397882, 12667.80998285045, 12804.167729097579, 13451.932740336628, 13625.86374136246, 13745.862541374458], "value": 7769.704874839342, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 112.0, 111.0, 113.0, 113.0, 112.0, 112.0, 114.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 121.0, 151.0, 121.0, 118.0, 116.0, 115.0, 143.0, 117.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 161.0, 160.0, 162.0, 161.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 109.0, 75.0, 76.0, 75.0, 76.0, 93.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 83.0, 83.0, 83.0, 96.0, 83.0, 83.0, 109.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 95.0, 94.0, 95.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 56.0, 55.0, 55.0, 53.0, 55.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 80.0, 75.0, 84.0, 79.0, 81.0, 83.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 131.0, 129.0, 128.0, 126.0, 130.0, 122.0, 159.0, 131.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 161.0, 157.0, 163.0, 158.0, 163.0, 156.0, 166.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0], "value": 59.7, "unit": "score"}]}]} 01:55:02 INFO - Return code: 0 01:55:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:55:02 ERROR - # TBPL SUCCESS # 01:55:02 INFO - Running post-action listener: _resource_record_post_action 01:55:02 INFO - [mozharness: 2017-05-04 08:55:02.274313Z] Finished run-tests step (success) 01:55:02 INFO - Running post-run listener: _resource_record_post_run 01:55:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 262144; Write bytes: 365596672; Read time: 24; Write time: 258092 01:55:02 INFO - TinderboxPrint: CPU usage
13.2% 01:55:02 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 24 01:55:02 INFO - TinderboxPrint: I/O write bytes / time
365,596,672 / 258,092 01:55:02 INFO - TinderboxPrint: CPU idle
8,267.7 (86.8%) 01:55:02 INFO - TinderboxPrint: CPU user
1,206.5 (12.7%) 01:55:02 INFO - TinderboxPrint: Swap in / out
0 / 0 01:55:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106217472; Read time: 0; Write time: 117960 01:55:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 262144; Write bytes: 259379200; Read time: 24; Write time: 140132 01:55:02 INFO - Running post-run listener: _upload_blobber_files 01:55:02 INFO - Blob upload gear active. 01:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:55:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:55:03 INFO - (blobuploader) - INFO - Open directory for files ... 01:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:04 INFO - (blobuploader) - INFO - Done attempting. 01:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:05 INFO - (blobuploader) - INFO - Done attempting. 01:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:06 INFO - (blobuploader) - INFO - Done attempting. 01:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:09 INFO - (blobuploader) - INFO - Done attempting. 01:55:09 INFO - (blobuploader) - INFO - Iteration through files over. 01:55:09 INFO - Return code: 0 01:55:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:55:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:55:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3df3f16e84adc0feed5a48bc686fd4c21589e60188cdb4ce930d212fb017e51aaf641e316ef1614f71d13a487a4c2393bac7719f6ff7c68499867a5d41ea2a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/196e875a7114cce7d9b40b80ae5b2536ee2edd10d0350e351e329bc931a8ffda00879a57d2c0ca1f864517d3075b99e38477be6d38acffdc49cfc6fe0e6e50ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f31ad4846f416ae95002233bd14d083ee1a678efe85b35c61f6d363712a96c209807ebab303e21bd7e905a65c3b83d0c731867d0f686800c5a5a991d32aebf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/42cd9ae77782203892ba24398d7f1a62b179469c8985dfbfe1472b33e30d3bed955c4fa2af4f71f267bfb296ef9a9c4afc3683520f5300b6264b4bc855bfe300"} 01:55:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:55:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:55:09 INFO - Contents: 01:55:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3df3f16e84adc0feed5a48bc686fd4c21589e60188cdb4ce930d212fb017e51aaf641e316ef1614f71d13a487a4c2393bac7719f6ff7c68499867a5d41ea2a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/196e875a7114cce7d9b40b80ae5b2536ee2edd10d0350e351e329bc931a8ffda00879a57d2c0ca1f864517d3075b99e38477be6d38acffdc49cfc6fe0e6e50ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f31ad4846f416ae95002233bd14d083ee1a678efe85b35c61f6d363712a96c209807ebab303e21bd7e905a65c3b83d0c731867d0f686800c5a5a991d32aebf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/42cd9ae77782203892ba24398d7f1a62b179469c8985dfbfe1472b33e30d3bed955c4fa2af4f71f267bfb296ef9a9c4afc3683520f5300b6264b4bc855bfe300"} 01:55:09 INFO - Running post-run listener: copy_logs_to_upload_dir 01:55:09 INFO - Copying logs to upload dir... 01:55:09 INFO - mkdir: /builds/slave/test/build/upload/logs 01:55:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.462682 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-04 01:55:09.512854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 01:55:09.517834) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3df3f16e84adc0feed5a48bc686fd4c21589e60188cdb4ce930d212fb017e51aaf641e316ef1614f71d13a487a4c2393bac7719f6ff7c68499867a5d41ea2a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/196e875a7114cce7d9b40b80ae5b2536ee2edd10d0350e351e329bc931a8ffda00879a57d2c0ca1f864517d3075b99e38477be6d38acffdc49cfc6fe0e6e50ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f31ad4846f416ae95002233bd14d083ee1a678efe85b35c61f6d363712a96c209807ebab303e21bd7e905a65c3b83d0c731867d0f686800c5a5a991d32aebf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/42cd9ae77782203892ba24398d7f1a62b179469c8985dfbfe1472b33e30d3bed955c4fa2af4f71f267bfb296ef9a9c4afc3683520f5300b6264b4bc855bfe300"} build_url:https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/Q9rlsIaqQLiHleSG6SiT5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3df3f16e84adc0feed5a48bc686fd4c21589e60188cdb4ce930d212fb017e51aaf641e316ef1614f71d13a487a4c2393bac7719f6ff7c68499867a5d41ea2a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/196e875a7114cce7d9b40b80ae5b2536ee2edd10d0350e351e329bc931a8ffda00879a57d2c0ca1f864517d3075b99e38477be6d38acffdc49cfc6fe0e6e50ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f31ad4846f416ae95002233bd14d083ee1a678efe85b35c61f6d363712a96c209807ebab303e21bd7e905a65c3b83d0c731867d0f686800c5a5a991d32aebf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/42cd9ae77782203892ba24398d7f1a62b179469c8985dfbfe1472b33e30d3bed955c4fa2af4f71f267bfb296ef9a9c4afc3683520f5300b6264b4bc855bfe300"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 01:55:09.546651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:55:09.547149) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493886662.778349-221818652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:55:09.627249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 01:55:09.627585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 01:55:09.627883) ========= ========= Total master_lag: 0.23 =========