builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1483455421.23 results: success (0) revision: e5e607abb3b91048542e7d49334461d86277300f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.227821) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.228332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.228666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.252656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.253040) ========= 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=41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-03 06:57:03-- 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% 46.4M=0s 2017-01-03 06:57:03 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.344927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.345270) ========= 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=41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016875 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.412662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:01.413026) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev e5e607abb3b91048542e7d49334461d86277300f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev e5e607abb3b91048542e7d49334461d86277300f --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=41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-03 06:57:03,205 truncating revision to first 12 chars 2017-01-03 06:57:03,205 Setting DEBUG logging. 2017-01-03 06:57:03,205 attempt 1/10 2017-01-03 06:57:03,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/e5e607abb3b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 06:57:03,500 unpacking tar archive at: graphics-e5e607abb3b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:02.037116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:02.037472) ========= script_repo_revision: e5e607abb3b91048542e7d49334461d86277300f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:02.037936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:02.038325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 06:57:02.048217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-03 06:57:02.048654) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:03 INFO - MultiFileLogger online at 20170103 06:57:03 in /builds/slave/test 06:57:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 06:57:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:03 INFO - {'append_to_log': False, 06:57:03 INFO - 'base_work_dir': '/builds/slave/test', 06:57:03 INFO - 'blob_upload_branch': 'Graphics', 06:57:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:03 INFO - 'branch': 'Graphics', 06:57:03 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:03 INFO - 'config_files': ('talos/linux_config.py',), 06:57:03 INFO - 'default_actions': ('clobber', 06:57:03 INFO - 'read-buildbot-config', 06:57:03 INFO - 'download-and-extract', 06:57:03 INFO - 'populate-webroot', 06:57:03 INFO - 'create-virtualenv', 06:57:03 INFO - 'install', 06:57:03 INFO - 'run-tests'), 06:57:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:03 INFO - 'download_minidump_stackwalk': True, 06:57:03 INFO - 'download_symbols': 'ondemand', 06:57:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:03 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:03 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:03 INFO - 'installer_path': 'installer.exe', 06:57:03 INFO - 'log_level': 'info', 06:57:03 INFO - 'log_name': 'talos', 06:57:03 INFO - 'log_to_console': True, 06:57:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:03 INFO - 'opt_config_files': (), 06:57:03 INFO - 'pip_index': False, 06:57:03 INFO - 'sps_profile': False, 06:57:03 INFO - 'sps_profile_interval': 0, 06:57:03 INFO - 'suite': 'dromaeojs', 06:57:03 INFO - 'system_bits': '32', 06:57:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:03 INFO - 'title': 'talos-linux64-ix-026', 06:57:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:03 INFO - 'use_talos_json': True, 06:57:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:03 INFO - 'work_dir': 'build'} 06:57:03 INFO - [mozharness: 2017-01-03 14:57:03.940798Z] Running clobber step. 06:57:03 INFO - Running pre-action listener: _resource_record_pre_action 06:57:03 INFO - Running main action method: clobber 06:57:03 INFO - rmtree: /builds/slave/test/build 06:57:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:04 INFO - Running post-action listener: _resource_record_post_action 06:57:04 INFO - [mozharness: 2017-01-03 14:57:04.407029Z] Finished clobber step (success) 06:57:04 INFO - [mozharness: 2017-01-03 14:57:04.407131Z] Running read-buildbot-config step. 06:57:04 INFO - Running pre-action listener: _resource_record_pre_action 06:57:04 INFO - Running main action method: read_buildbot_config 06:57:04 INFO - Using buildbot properties: 06:57:04 INFO - { 06:57:04 INFO - "project": "", 06:57:04 INFO - "product": "firefox", 06:57:04 INFO - "who": "kgupta@mozilla.com", 06:57:04 INFO - "installer_path": "public/build/target.tar.bz2", 06:57:04 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 06:57:04 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 06:57:04 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 06:57:04 INFO - "stage_platform": "linux64", 06:57:04 INFO - "basedir": "/builds/slave/test", 06:57:04 INFO - "buildnumber": 39, 06:57:04 INFO - "platform": "ubuntu64_hw", 06:57:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:57:04 INFO - "slavebuilddir": "test", 06:57:04 INFO - "taskId": "JJe8NoF9SV6bdKqhoMxMeg", 06:57:04 INFO - "branch": "graphics", 06:57:04 INFO - "script_repo_revision": "default", 06:57:04 INFO - "revision": "e5e607abb3b91048542e7d49334461d86277300f", 06:57:04 INFO - "slavename": "talos-linux64-ix-026", 06:57:04 INFO - "repo_path": "projects/graphics" 06:57:04 INFO - } 06:57:04 INFO - Finding installer, test and symbols from parent task. 06:57:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JJe8NoF9SV6bdKqhoMxMeg'}, attempt #1 06:57:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JJe8NoF9SV6bdKqhoMxMeg'}, attempt #1 06:57:05 INFO - Task dependencies: ZA_lOUtNQt6_yKiVL_8Maw 06:57:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw'}, attempt #1 06:57:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2 06:57:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/test_packages.json 06:57:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.crashreporter-symbols.zip 06:57:05 INFO - Running post-action listener: _resource_record_post_action 06:57:05 INFO - [mozharness: 2017-01-03 14:57:05.789339Z] Finished read-buildbot-config step (success) 06:57:05 INFO - [mozharness: 2017-01-03 14:57:05.789606Z] Running download-and-extract step. 06:57:05 INFO - Running pre-action listener: _resource_record_pre_action 06:57:05 INFO - Running main action method: download_and_extract 06:57:05 INFO - mkdir: /builds/slave/test/build/tests 06:57:05 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')]} 06:57:05 INFO - trying https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.test_packages.json 06:57:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:57:06 INFO - Downloaded 896 bytes. 06:57:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:57:06 INFO - Using the following test package requirements: 06:57:06 INFO - {u'common': [u'target.common.tests.zip'], 06:57:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:57:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:57:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:57:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:57:06 INFO - u'mozbase': [u'target.common.tests.zip'], 06:57:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:57:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:57:06 INFO - u'web-platform': [u'target.common.tests.zip', 06:57:06 INFO - u'target.web-platform.tests.zip'], 06:57:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:57:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:57:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.common.tests.zip 06:57:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.common.tests.zip into memory 06:57:07 INFO - Expected file size: 20246919 06:57:07 INFO - Obtained file size: 20246919 06:57:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:57:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.common.tests.zip 06:57:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.common.tests.zip into memory 06:57:11 INFO - Expected file size: 20246919 06:57:11 INFO - Obtained file size: 20246919 06:57:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.talos.tests.zip 06:57:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:57:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.talos.tests.zip into memory 06:57:17 INFO - Expected file size: 14409776 06:57:17 INFO - Obtained file size: 14409776 06:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:17 INFO - trying https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2 06:57:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:57:18 INFO - Downloaded 55727588 bytes. 06:57:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2 06:57:18 INFO - mkdir: /builds/slave/test/properties 06:57:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:57:18 INFO - Writing to file /builds/slave/test/properties/build_url 06:57:18 INFO - Contents: 06:57:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2 06:57:18 INFO - Running post-action listener: _resource_record_post_action 06:57:18 INFO - Running post-action listener: set_extra_try_arguments 06:57:18 INFO - [mozharness: 2017-01-03 14:57:18.397024Z] Finished download-and-extract step (success) 06:57:18 INFO - [mozharness: 2017-01-03 14:57:18.397121Z] Running populate-webroot step. 06:57:18 INFO - Running pre-action listener: _resource_record_pre_action 06:57:18 INFO - Running main action method: populate_webroot 06:57:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:18 INFO - '--tppagecycles', 06:57:18 INFO - '7'], 06:57:18 INFO - 'tests': ['tsvgm']}}, 06:57:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:57:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:57:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:57:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:57:18 INFO - 'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:57:18 INFO - 'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['damp', 'tps']}, 06:57:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:57:18 INFO - 'tests': ['damp', 'tps']}, 06:57:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['dromaeo_dom']}, 06:57:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['basic_compositor_video']}, 06:57:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:57:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['a11yr', 06:57:18 INFO - 'ts_paint', 06:57:18 INFO - 'tpaint', 06:57:18 INFO - 'sessionrestore', 06:57:18 INFO - 'sessionrestore_no_auto_restore', 06:57:18 INFO - 'tabpaint']}, 06:57:18 INFO - 'other-e10s': {'tests': ['a11yr', 06:57:18 INFO - 'ts_paint', 06:57:18 INFO - 'tpaint', 06:57:18 INFO - 'sessionrestore', 06:57:18 INFO - 'sessionrestore_no_auto_restore', 06:57:18 INFO - 'tabpaint']}, 06:57:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:57:18 INFO - 'ts_paint', 06:57:18 INFO - 'tpaint', 06:57:18 INFO - 'sessionrestore', 06:57:18 INFO - 'sessionrestore_no_auto_restore', 06:57:18 INFO - 'tabpaint']}, 06:57:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:57:18 INFO - 'ts_paint', 06:57:18 INFO - 'tpaint', 06:57:18 INFO - 'sessionrestore', 06:57:18 INFO - 'sessionrestore_no_auto_restore', 06:57:18 INFO - 'tabpaint']}, 06:57:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['a11yr', 06:57:18 INFO - 'ts_paint', 06:57:18 INFO - 'tpaint', 06:57:18 INFO - 'sessionrestore', 06:57:18 INFO - 'sessionrestore_no_auto_restore', 06:57:18 INFO - 'tabpaint']}, 06:57:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['a11yr', 06:57:18 INFO - 'ts_paint', 06:57:18 INFO - 'tpaint', 06:57:18 INFO - 'sessionrestore', 06:57:18 INFO - 'sessionrestore_no_auto_restore', 06:57:18 INFO - 'tabpaint']}, 06:57:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['tsvgx', 06:57:18 INFO - 'tsvgr_opacity', 06:57:18 INFO - 'tart', 06:57:18 INFO - 'tscrollx', 06:57:18 INFO - 'cart', 06:57:18 INFO - 'tsvg_static']}, 06:57:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:57:18 INFO - 'tsvgr_opacity', 06:57:18 INFO - 'tart', 06:57:18 INFO - 'tscrollx', 06:57:18 INFO - 'cart', 06:57:18 INFO - 'tsvg_static']}, 06:57:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:57:18 INFO - 'talos_options': ['--disable-e10s'], 06:57:18 INFO - 'tests': ['tp5o']}, 06:57:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:57:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:57:18 INFO - 'talos_options': ['--disable-e10s', 06:57:18 INFO - '--xperf_path', 06:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:18 INFO - 'tests': ['tp5n']}, 06:57:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:57:18 INFO - 'talos_options': ['--xperf_path', 06:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:18 INFO - 'tests': ['tp5n']}}, 06:57:18 INFO - 'talos.zip': {'path': '', 06:57:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:18 INFO - Running post-action listener: _resource_record_post_action 06:57:18 INFO - [mozharness: 2017-01-03 14:57:18.410472Z] Finished populate-webroot step (success) 06:57:18 INFO - [mozharness: 2017-01-03 14:57:18.410568Z] Running create-virtualenv step. 06:57:18 INFO - Running pre-action listener: _resource_record_pre_action 06:57:18 INFO - Running main action method: create_virtualenv 06:57:18 INFO - Creating virtualenv /builds/slave/test/build/venv 06:57:18 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 06:57:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:57:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:18 INFO - Using real prefix '/usr' 06:57:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:57:19 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:20 INFO - Installing pip.................done. 06:57:20 INFO - Return code: 0 06:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:57:21 INFO - Reading from file tmpfile_stdout 06:57:21 INFO - Output received: 06:57:21 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) 06:57:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:57:21 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')]} 06:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:21 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')]} 06:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:21 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:21 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 06:57:21 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 06:57:21 INFO - Using env: {'DISPLAY': ':0', 06:57:21 INFO - 'HOME': '/home/cltbld', 06:57:21 INFO - 'LANG': 'en_US.UTF-8', 06:57:21 INFO - 'LANGUAGE': 'en_US:en', 06:57:21 INFO - 'LOGNAME': 'cltbld', 06:57:21 INFO - 'MAIL': '/var/mail/cltbld', 06:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:21 INFO - 'MOZ_NO_REMOTE': '1', 06:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:21 INFO - 'NO_EM_RESTART': '1', 06:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:21 INFO - 'PWD': '/builds/slave/test', 06:57:21 INFO - 'SHELL': '/bin/bash', 06:57:21 INFO - 'SHLVL': '1', 06:57:21 INFO - 'TERM': 'linux', 06:57:21 INFO - 'TMOUT': '86400', 06:57:21 INFO - 'USER': 'cltbld', 06:57:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:21 INFO - '_': '/tools/buildbot/bin/python'} 06:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:21 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 06:57:21 INFO - Cleaning up... 06:57:21 INFO - Return code: 0 06:57:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:57:21 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')]} 06:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:21 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')]} 06:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:21 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:21 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 06:57:21 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 06:57:21 INFO - Using env: {'DISPLAY': ':0', 06:57:21 INFO - 'HOME': '/home/cltbld', 06:57:21 INFO - 'LANG': 'en_US.UTF-8', 06:57:21 INFO - 'LANGUAGE': 'en_US:en', 06:57:21 INFO - 'LOGNAME': 'cltbld', 06:57:21 INFO - 'MAIL': '/var/mail/cltbld', 06:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:21 INFO - 'MOZ_NO_REMOTE': '1', 06:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:21 INFO - 'NO_EM_RESTART': '1', 06:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:21 INFO - 'PWD': '/builds/slave/test', 06:57:21 INFO - 'SHELL': '/bin/bash', 06:57:21 INFO - 'SHLVL': '1', 06:57:21 INFO - 'TERM': 'linux', 06:57:21 INFO - 'TMOUT': '86400', 06:57:21 INFO - 'USER': 'cltbld', 06:57:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:21 INFO - '_': '/tools/buildbot/bin/python'} 06:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:21 INFO - Downloading/unpacking psutil>=3.1.1 06:57:21 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 06:57:21 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 06:57:21 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 06:57:21 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 06:57:21 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 06:57:21 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 06:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:23 INFO - Installing collected packages: psutil 06:57:23 INFO - Running setup.py install for psutil 06:57:23 INFO - building 'psutil._psutil_linux' extension 06:57:23 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 06:57:23 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 06:57:24 INFO - building 'psutil._psutil_posix' extension 06:57:24 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 06:57:24 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 06:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:24 INFO - Successfully installed psutil 06:57:24 INFO - Cleaning up... 06:57:24 INFO - Return code: 0 06:57:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:24 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:24 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 06:57:24 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 06:57:24 INFO - Using env: {'DISPLAY': ':0', 06:57:24 INFO - 'HOME': '/home/cltbld', 06:57:24 INFO - 'LANG': 'en_US.UTF-8', 06:57:24 INFO - 'LANGUAGE': 'en_US:en', 06:57:24 INFO - 'LOGNAME': 'cltbld', 06:57:24 INFO - 'MAIL': '/var/mail/cltbld', 06:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:24 INFO - 'MOZ_NO_REMOTE': '1', 06:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:24 INFO - 'NO_EM_RESTART': '1', 06:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:24 INFO - 'PWD': '/builds/slave/test', 06:57:24 INFO - 'SHELL': '/bin/bash', 06:57:24 INFO - 'SHLVL': '1', 06:57:24 INFO - 'TERM': 'linux', 06:57:24 INFO - 'TMOUT': '86400', 06:57:24 INFO - 'USER': 'cltbld', 06:57:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:24 INFO - '_': '/tools/buildbot/bin/python'} 06:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:57:24 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 06:57:24 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 06:57:24 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 06:57:24 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 06:57:24 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 06:57:24 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 06:57:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:57:26 INFO - Installing collected packages: mozsystemmonitor 06:57:26 INFO - Running setup.py install for mozsystemmonitor 06:57:26 INFO - Successfully installed mozsystemmonitor 06:57:26 INFO - Cleaning up... 06:57:26 INFO - Return code: 0 06:57:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:57:26 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')]} 06:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:26 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')]} 06:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:26 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:26 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 06:57:26 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 06:57:26 INFO - Using env: {'DISPLAY': ':0', 06:57:26 INFO - 'HOME': '/home/cltbld', 06:57:26 INFO - 'LANG': 'en_US.UTF-8', 06:57:26 INFO - 'LANGUAGE': 'en_US:en', 06:57:26 INFO - 'LOGNAME': 'cltbld', 06:57:26 INFO - 'MAIL': '/var/mail/cltbld', 06:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:26 INFO - 'MOZ_NO_REMOTE': '1', 06:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:26 INFO - 'NO_EM_RESTART': '1', 06:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:26 INFO - 'PWD': '/builds/slave/test', 06:57:26 INFO - 'SHELL': '/bin/bash', 06:57:26 INFO - 'SHLVL': '1', 06:57:26 INFO - 'TERM': 'linux', 06:57:26 INFO - 'TMOUT': '86400', 06:57:26 INFO - 'USER': 'cltbld', 06:57:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:26 INFO - '_': '/tools/buildbot/bin/python'} 06:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:26 INFO - Downloading/unpacking jsonschema==2.5.1 06:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:57:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:29 INFO - Downloading functools32-3.2.3-2.tar.gz 06:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:57:29 INFO - warning: no files found matching '*.txt' 06:57:29 INFO - no previously-included directories found matching 'build' 06:57:29 INFO - no previously-included directories found matching 'dist' 06:57:29 INFO - no previously-included directories found matching '.git*' 06:57:29 INFO - Installing collected packages: jsonschema, functools32 06:57:29 INFO - Running setup.py install for functools32 06:57:29 INFO - warning: no files found matching '*.txt' 06:57:29 INFO - no previously-included directories found matching 'build' 06:57:29 INFO - no previously-included directories found matching 'dist' 06:57:29 INFO - no previously-included directories found matching '.git*' 06:57:29 INFO - Successfully installed jsonschema functools32 06:57:29 INFO - Cleaning up... 06:57:29 INFO - Return code: 0 06:57:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:57:29 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')]} 06:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:29 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')]} 06:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:29 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:29 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 06:57:29 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 06:57:29 INFO - Using env: {'DISPLAY': ':0', 06:57:29 INFO - 'HOME': '/home/cltbld', 06:57:29 INFO - 'LANG': 'en_US.UTF-8', 06:57:29 INFO - 'LANGUAGE': 'en_US:en', 06:57:29 INFO - 'LOGNAME': 'cltbld', 06:57:29 INFO - 'MAIL': '/var/mail/cltbld', 06:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:29 INFO - 'MOZ_NO_REMOTE': '1', 06:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:29 INFO - 'NO_EM_RESTART': '1', 06:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:29 INFO - 'PWD': '/builds/slave/test', 06:57:29 INFO - 'SHELL': '/bin/bash', 06:57:29 INFO - 'SHLVL': '1', 06:57:29 INFO - 'TERM': 'linux', 06:57:29 INFO - 'TMOUT': '86400', 06:57:29 INFO - 'USER': 'cltbld', 06:57:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:29 INFO - '_': '/tools/buildbot/bin/python'} 06:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:57:29 INFO - Cleaning up... 06:57:29 INFO - Return code: 0 06:57:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:57:29 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')]} 06:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:29 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')]} 06:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:29 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:29 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 06:57:29 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 06:57:29 INFO - Using env: {'DISPLAY': ':0', 06:57:29 INFO - 'HOME': '/home/cltbld', 06:57:29 INFO - 'LANG': 'en_US.UTF-8', 06:57:29 INFO - 'LANGUAGE': 'en_US:en', 06:57:29 INFO - 'LOGNAME': 'cltbld', 06:57:29 INFO - 'MAIL': '/var/mail/cltbld', 06:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:29 INFO - 'MOZ_NO_REMOTE': '1', 06:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:29 INFO - 'NO_EM_RESTART': '1', 06:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:29 INFO - 'PWD': '/builds/slave/test', 06:57:29 INFO - 'SHELL': '/bin/bash', 06:57:29 INFO - 'SHLVL': '1', 06:57:29 INFO - 'TERM': 'linux', 06:57:29 INFO - 'TMOUT': '86400', 06:57:29 INFO - 'USER': 'cltbld', 06:57:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:29 INFO - '_': '/tools/buildbot/bin/python'} 06:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:29 INFO - Downloading/unpacking blobuploader==1.2.4 06:57:29 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 06:57:29 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 06:57:29 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 06:57:29 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 06:57:29 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 06:57:29 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 06:57:31 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:57:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:32 INFO - Downloading docopt-0.6.1.tar.gz 06:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:32 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:32 INFO - Running setup.py install for blobuploader 06:57:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:57:32 INFO - Running setup.py install for requests 06:57:33 INFO - Running setup.py install for docopt 06:57:33 INFO - Successfully installed blobuploader requests docopt 06:57:33 INFO - Cleaning up... 06:57:33 INFO - Return code: 0 06:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:33 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:33 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 06:57:33 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 06:57:33 INFO - Using env: {'DISPLAY': ':0', 06:57:33 INFO - 'HOME': '/home/cltbld', 06:57:33 INFO - 'LANG': 'en_US.UTF-8', 06:57:33 INFO - 'LANGUAGE': 'en_US:en', 06:57:33 INFO - 'LOGNAME': 'cltbld', 06:57:33 INFO - 'MAIL': '/var/mail/cltbld', 06:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:33 INFO - 'MOZ_NO_REMOTE': '1', 06:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:33 INFO - 'NO_EM_RESTART': '1', 06:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:33 INFO - 'PWD': '/builds/slave/test', 06:57:33 INFO - 'SHELL': '/bin/bash', 06:57:33 INFO - 'SHLVL': '1', 06:57:33 INFO - 'TERM': 'linux', 06:57:33 INFO - 'TMOUT': '86400', 06:57:33 INFO - 'USER': 'cltbld', 06:57:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:33 INFO - '_': '/tools/buildbot/bin/python'} 06:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:33 INFO - Running setup.py (path:/tmp/pip-cZOSBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:33 INFO - Running setup.py (path:/tmp/pip-kz5uFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:33 INFO - Running setup.py (path:/tmp/pip-XMaUh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:33 INFO - Running setup.py (path:/tmp/pip-pdJNMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:34 INFO - Running setup.py (path:/tmp/pip-GPNuVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:34 INFO - Running setup.py (path:/tmp/pip-7HfaPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:34 INFO - Running setup.py (path:/tmp/pip-vPE913-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:34 INFO - Running setup.py (path:/tmp/pip-02qaw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:34 INFO - Running setup.py (path:/tmp/pip-23G1sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:34 INFO - Running setup.py (path:/tmp/pip-Rq187_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:34 INFO - Running setup.py (path:/tmp/pip-77IwjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:34 INFO - Running setup.py (path:/tmp/pip-6HrGpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:34 INFO - Running setup.py (path:/tmp/pip-ndzO9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:34 INFO - Running setup.py (path:/tmp/pip-HJvETE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:34 INFO - Running setup.py (path:/tmp/pip-YE4MpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:34 INFO - Running setup.py (path:/tmp/pip-JFZf6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:34 INFO - Running setup.py (path:/tmp/pip-8Je_7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:34 INFO - Running setup.py install for manifestparser 06:57:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Running setup.py install for mozcrash 06:57:35 INFO - Running setup.py install for mozdebug 06:57:35 INFO - Running setup.py install for mozdevice 06:57:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Running setup.py install for mozfile 06:57:35 INFO - Running setup.py install for mozhttpd 06:57:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Running setup.py install for mozinfo 06:57:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Running setup.py install for mozInstall 06:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:57:35 INFO - Running setup.py install for mozleak 06:57:35 INFO - Running setup.py install for mozlog 06:57:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:57:36 INFO - Running setup.py install for moznetwork 06:57:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:57:36 INFO - Running setup.py install for mozprocess 06:57:36 INFO - Running setup.py install for mozprofile 06:57:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:57:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:57:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:57:36 INFO - Running setup.py install for mozrunner 06:57:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:57:36 INFO - Running setup.py install for mozscreenshot 06:57:36 INFO - Running setup.py install for moztest 06:57:36 INFO - Running setup.py install for mozversion 06:57:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:57:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:36 INFO - Cleaning up... 06:57:36 INFO - Return code: 0 06:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:36 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')]} 06:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:36 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')]} 06:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:36 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:36 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 06:57:36 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 06:57:36 INFO - Using env: {'DISPLAY': ':0', 06:57:36 INFO - 'HOME': '/home/cltbld', 06:57:36 INFO - 'LANG': 'en_US.UTF-8', 06:57:36 INFO - 'LANGUAGE': 'en_US:en', 06:57:36 INFO - 'LOGNAME': 'cltbld', 06:57:36 INFO - 'MAIL': '/var/mail/cltbld', 06:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:36 INFO - 'MOZ_NO_REMOTE': '1', 06:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:36 INFO - 'NO_EM_RESTART': '1', 06:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:36 INFO - 'PWD': '/builds/slave/test', 06:57:36 INFO - 'SHELL': '/bin/bash', 06:57:36 INFO - 'SHLVL': '1', 06:57:36 INFO - 'TERM': 'linux', 06:57:36 INFO - 'TMOUT': '86400', 06:57:36 INFO - 'USER': 'cltbld', 06:57:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:36 INFO - '_': '/tools/buildbot/bin/python'} 06:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:37 INFO - Running setup.py (path:/tmp/pip-o2JYMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:37 INFO - Running setup.py (path:/tmp/pip-7YUraD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:37 INFO - Running setup.py (path:/tmp/pip-zxQFZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:37 INFO - Running setup.py (path:/tmp/pip-4TgaBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:37 INFO - Running setup.py (path:/tmp/pip-y4RKOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:37 INFO - Running setup.py (path:/tmp/pip-dXwukk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:37 INFO - Running setup.py (path:/tmp/pip-JiUEQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:37 INFO - Running setup.py (path:/tmp/pip-EB7r_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:37 INFO - Running setup.py (path:/tmp/pip-gXFmTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:37 INFO - Running setup.py (path:/tmp/pip-aAIzNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:37 INFO - Running setup.py (path:/tmp/pip-Hej5Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:37 INFO - Running setup.py (path:/tmp/pip-YvQEql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:37 INFO - Running setup.py (path:/tmp/pip-YEteTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:37 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)) 06:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:37 INFO - Running setup.py (path:/tmp/pip-uEydjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:38 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)) 06:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:38 INFO - Running setup.py (path:/tmp/pip-BArPvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:38 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)) 06:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:38 INFO - Running setup.py (path:/tmp/pip-VVvs_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:38 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)) 06:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:38 INFO - Running setup.py (path:/tmp/pip-G2Ee4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:38 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)) 06:57:38 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)) 06:57:38 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)) 06:57:38 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)) 06:57:38 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)) 06:57:38 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)) 06:57:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:38 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 06:57:38 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 06:57:38 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 06:57:38 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 06:57:38 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 06:57:38 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 06:57:40 INFO - Downloading blessings-1.6.tar.gz 06:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:40 INFO - Installing collected packages: blessings 06:57:40 INFO - Running setup.py install for blessings 06:57:40 INFO - Successfully installed blessings 06:57:40 INFO - Cleaning up... 06:57:40 INFO - Return code: 0 06:57:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:40 INFO - Reading from file tmpfile_stdout 06:57:40 INFO - Current package versions: 06:57:40 INFO - argparse == 1.2.1 06:57:40 INFO - blessings == 1.6 06:57:40 INFO - blobuploader == 1.2.4 06:57:40 INFO - docopt == 0.6.1 06:57:40 INFO - functools32 == 3.2.3-2 06:57:40 INFO - jsonschema == 2.5.1 06:57:40 INFO - manifestparser == 1.1 06:57:40 INFO - mozInstall == 1.12 06:57:40 INFO - mozcrash == 1.0 06:57:40 INFO - mozdebug == 0.1 06:57:40 INFO - mozdevice == 0.49 06:57:40 INFO - mozfile == 1.2 06:57:40 INFO - mozhttpd == 0.7 06:57:40 INFO - mozinfo == 0.9 06:57:40 INFO - mozleak == 0.1 06:57:40 INFO - mozlog == 3.4 06:57:40 INFO - moznetwork == 0.27 06:57:40 INFO - mozprocess == 0.23 06:57:40 INFO - mozprofile == 0.28 06:57:40 INFO - mozrunner == 6.13 06:57:40 INFO - mozscreenshot == 0.1 06:57:40 INFO - mozsystemmonitor == 0.3 06:57:40 INFO - moztest == 0.8 06:57:40 INFO - mozversion == 1.4 06:57:40 INFO - psutil == 3.1.1 06:57:40 INFO - requests == 1.2.3 06:57:40 INFO - wsgiref == 0.1.2 06:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:40 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')]} 06:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:40 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')]} 06:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:40 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:40 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 06:57:40 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 06:57:40 INFO - Using env: {'DISPLAY': ':0', 06:57:40 INFO - 'HOME': '/home/cltbld', 06:57:40 INFO - 'LANG': 'en_US.UTF-8', 06:57:40 INFO - 'LANGUAGE': 'en_US:en', 06:57:40 INFO - 'LOGNAME': 'cltbld', 06:57:40 INFO - 'MAIL': '/var/mail/cltbld', 06:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:40 INFO - 'MOZ_NO_REMOTE': '1', 06:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:40 INFO - 'NO_EM_RESTART': '1', 06:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:40 INFO - 'PWD': '/builds/slave/test', 06:57:40 INFO - 'SHELL': '/bin/bash', 06:57:40 INFO - 'SHLVL': '1', 06:57:40 INFO - 'TERM': 'linux', 06:57:40 INFO - 'TMOUT': '86400', 06:57:40 INFO - 'USER': 'cltbld', 06:57:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:40 INFO - '_': '/tools/buildbot/bin/python'} 06:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 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)) 06:57:40 INFO - Cleaning up... 06:57:40 INFO - Return code: 0 06:57:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:57:40 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')]} 06:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:40 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')]} 06:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:40 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 0x1f971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2308c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, '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': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', '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 06:57:40 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 06:57:40 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 06:57:40 INFO - Using env: {'DISPLAY': ':0', 06:57:40 INFO - 'HOME': '/home/cltbld', 06:57:40 INFO - 'LANG': 'en_US.UTF-8', 06:57:40 INFO - 'LANGUAGE': 'en_US:en', 06:57:40 INFO - 'LOGNAME': 'cltbld', 06:57:40 INFO - 'MAIL': '/var/mail/cltbld', 06:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:40 INFO - 'MOZ_NO_REMOTE': '1', 06:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:40 INFO - 'NO_EM_RESTART': '1', 06:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:40 INFO - 'PWD': '/builds/slave/test', 06:57:40 INFO - 'SHELL': '/bin/bash', 06:57:40 INFO - 'SHLVL': '1', 06:57:40 INFO - 'TERM': 'linux', 06:57:40 INFO - 'TMOUT': '86400', 06:57:40 INFO - 'USER': 'cltbld', 06:57:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:40 INFO - '_': '/tools/buildbot/bin/python'} 06:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:57:41 INFO - Cleaning up... 06:57:41 INFO - Return code: 0 06:57:41 INFO - Running post-action listener: _resource_record_post_action 06:57:41 INFO - Running post-action listener: _start_resource_monitoring 06:57:41 INFO - Starting resource monitoring. 06:57:41 INFO - [mozharness: 2017-01-03 14:57:41.220685Z] Finished create-virtualenv step (success) 06:57:41 INFO - [mozharness: 2017-01-03 14:57:41.221189Z] Running install step. 06:57:41 INFO - Running pre-action listener: _resource_record_pre_action 06:57:41 INFO - Running main action method: install 06:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:41 INFO - Reading from file tmpfile_stdout 06:57:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:57:41 INFO - Reading from file tmpfile_stdout 06:57:41 INFO - Output received: 06:57:41 INFO - Usage: mozinstall [options] installer 06:57:41 INFO - Options: 06:57:41 INFO - -h, --help show this help message and exit 06:57:41 INFO - -d DEST, --destination=DEST 06:57:41 INFO - Directory to install application into. [default: 06:57:41 INFO - "/builds/slave/test"] 06:57:41 INFO - --app=APP Application being installed. [default: firefox] 06:57:41 INFO - mkdir: /builds/slave/test/build/application 06:57:41 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'] 06:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:57:57 INFO - Reading from file tmpfile_stdout 06:57:57 INFO - Output received: 06:57:57 INFO - /builds/slave/test/build/application/firefox/firefox 06:57:57 INFO - Running post-action listener: _resource_record_post_action 06:57:57 INFO - [mozharness: 2017-01-03 14:57:57.593724Z] Finished install step (success) 06:57:57 INFO - [mozharness: 2017-01-03 14:57:57.594001Z] Running run-tests step. 06:57:57 INFO - Running pre-action listener: _resource_record_pre_action 06:57:57 INFO - Running main action method: run_tests 06:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:57:57 INFO - Python 2.7.3 06:57:57 INFO - Return code: 0 06:57:57 INFO - grabbing minidump binary from tooltool 06:57: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')]} 06:57:57 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 0x23063f0>, '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 0x2306cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23071a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:57:57 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 06:57:57 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 06:57:57 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 06:57:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:57:57 INFO - Return code: 0 06:57:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:57:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:57:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:57:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:57:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 06:57:57 INFO - Using env: {'DISPLAY': ':0', 06:57:57 INFO - 'HOME': '/home/cltbld', 06:57:57 INFO - 'LANG': 'en_US.UTF-8', 06:57:57 INFO - 'LANGUAGE': 'en_US:en', 06:57:57 INFO - 'LOGNAME': 'cltbld', 06:57:57 INFO - 'MAIL': '/var/mail/cltbld', 06:57:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:57:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:57 INFO - 'MOZ_NO_REMOTE': '1', 06:57:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:57 INFO - 'NO_EM_RESTART': '1', 06:57:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:57 INFO - 'PWD': '/builds/slave/test', 06:57:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:57:57 INFO - 'SHELL': '/bin/bash', 06:57:57 INFO - 'SHLVL': '1', 06:57:57 INFO - 'TERM': 'linux', 06:57:57 INFO - 'TMOUT': '86400', 06:57:57 INFO - 'USER': 'cltbld', 06:57:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287', 06:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:57 INFO - '_': '/tools/buildbot/bin/python'} 06:57:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:57:57 INFO - mozversion application_buildid: 20170103142540 06:57:57 INFO - mozversion application_changeset: e5e607abb3b91048542e7d49334461d86277300f 06:57:57 INFO - mozversion application_display_name: Nightly 06:57:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:57:57 INFO - mozversion application_name: Firefox 06:57:57 INFO - mozversion application_remotingname: firefox 06:57:57 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 06:57:57 INFO - mozversion application_vendor: Mozilla 06:57:57 INFO - mozversion application_version: 53.0a1 06:57:57 INFO - mozversion platform_buildid: 20170103142540 06:57:57 INFO - mozversion platform_changeset: e5e607abb3b91048542e7d49334461d86277300f 06:57:57 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 06:57:57 INFO - mozversion platform_version: 53.0a1 06:57:57 INFO - using testdate: 1483455477 06:57:57 INFO - actual date: 1483455477 06:57:57 INFO - starting webserver on 'localhost:60691' 06:57:57 INFO - SUITE-START | Running 2 tests 06:57:57 INFO - TEST-START | dromaeo_css 06:57:57 INFO - operating with platform_type : linux_ 06:57:57 INFO - Initialising browser for dromaeo_css test... 06:57:57 INFO - TEST-INFO | started process 28132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpasJ2zM/profile http://localhost:60691/getInfo.html) 06:57:58 INFO - PROCESS | 28132 | 1483455478391 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 06:58:01 INFO - PROCESS | 28132 | __metrics Screen width/height:1600/1200 06:58:01 INFO - PROCESS | 28132 | colorDepth:24 06:58:01 INFO - PROCESS | 28132 | Browser inner width/height: 1024/697 06:58:01 INFO - PROCESS | 28132 | __metrics 06:58:02 INFO - PROCESS | 28132 | 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" 06:58:02 INFO - PROCESS | 28132 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:58:02 INFO - PROCESS | 28132 | console.error: PushService: 06:58:02 INFO - PROCESS | 28132 | stateChangeProcessEnqueue: Error transitioning state 06:58:02 INFO - PROCESS | 28132 | UnknownError 06:58:03 INFO - TEST-INFO | 28132: exit 0 06:58:03 INFO - Browser initialized. 06:58:03 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:03 INFO - TEST-INFO | started process 28220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpasJ2zM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:15 INFO - PROCESS | 28220 | RSS: Main: 151228416 06:58:15 INFO - PROCESS | 28220 | 06:59:07 INFO - PROCESS | 28220 | 1483455547147 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:01:19 INFO - PROCESS | 28220 | Cycle 1(1): loaded http://localhost:60691/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60691/tests/dromaeo/cssquery-ext.html) 07:01:21 INFO - PROCESS | 28220 | RSS: Main: 245813248 07:01:21 INFO - PROCESS | 28220 | 07:03:04 INFO - PROCESS | 28220 | ************************* 07:03:04 INFO - PROCESS | 28220 | A coding exception was thrown and uncaught in a Task. 07:03:04 INFO - PROCESS | 28220 | 07:03:04 INFO - PROCESS | 28220 | Full message: ReferenceError: fetch is not defined 07:03:04 INFO - PROCESS | 28220 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:03:04 INFO - PROCESS | 28220 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:03:04 INFO - PROCESS | 28220 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:03:04 INFO - PROCESS | 28220 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:03:04 INFO - PROCESS | 28220 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:03:04 INFO - PROCESS | 28220 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:03:04 INFO - PROCESS | 28220 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:03:04 INFO - PROCESS | 28220 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:03:04 INFO - PROCESS | 28220 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:03:04 INFO - PROCESS | 28220 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:03:04 INFO - PROCESS | 28220 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:03:04 INFO - PROCESS | 28220 | 07:03:04 INFO - PROCESS | 28220 | ************************* 07:04:24 INFO - PROCESS | 28220 | Cycle 1(1): loaded http://localhost:60691/tests/dromaeo/cssquery-ext.html (next: http://localhost:60691/tests/dromaeo/cssquery-jquery.html) 07:04:24 INFO - PROCESS | 28220 | RSS: Main: 241422336 07:04:24 INFO - PROCESS | 28220 | 07:07:26 INFO - PROCESS | 28220 | Cycle 1(1): loaded http://localhost:60691/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60691/tests/dromaeo/cssquery-mootools.html) 07:07:27 INFO - PROCESS | 28220 | RSS: Main: 183341056 07:07:27 INFO - PROCESS | 28220 | 07:10:29 INFO - PROCESS | 28220 | Cycle 1(1): loaded http://localhost:60691/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60691/tests/dromaeo/cssquery-prototype.html) 07:10:30 INFO - PROCESS | 28220 | RSS: Main: 183222272 07:10:30 INFO - PROCESS | 28220 | 07:13:33 INFO - PROCESS | 28220 | Cycle 1(1): loaded http://localhost:60691/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60691/tests/dromaeo/cssquery-yui.html) 07:13:34 INFO - PROCESS | 28220 | RSS: Main: 184717312 07:13:34 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | Cycle 1(1): loaded http://localhost:60691/tests/dromaeo/cssquery-yui.html (next: http://localhost:60691/tests/dromaeo/cssquery-dojo.html) 07:16:37 INFO - PROCESS | 28220 | RSS: Main: 276713472 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | __start_tp_report 07:16:37 INFO - PROCESS | 28220 | _x_x_mozilla_page_load 07:16:37 INFO - PROCESS | 28220 | _x_x_mozilla_page_load_details 07:16:37 INFO - PROCESS | 28220 | |i|pagename|runs| 07:16:37 INFO - PROCESS | 28220 | |0;dojo.html;2532.8606926619036;2553.655256540367;2570.678665166854;2602.3364042169246;2609.5824668053115;4447.933281000779;4491.214037543433;4656.301554766783;4677.041206552657;4680.180968330541;4505.57197066279;4670.673052886299;4698.3892094027815;4735.408073990751;4752.215884379073;4274.7435153890865;4321.330193819963;4350.673699472536;4367.410399596046;4388.97805510972;3945.960540394588;4310.633596144332;4381.737095774248;4414.139242847646;4456.621187199092;4174.415581818548;4316.892077698051;4326.307790753464;4384.627306678936;4390.385346051556;4227.91544169118;4268.658507319407;4270.679699022555;4277.893052673677;4284.164587905359;4217.093324935154;4231;4238.766867822269;4243.236217480852;4247.277962746341;4595.517470665565;4595.9080818383445;4596.931046034312;4629.675922685414;4659.836905708318;4963.3299504566785;4970.453250142481;4976.601871850244;5021.472745361721;5024.045431368028;5025.924611130836;5034.043531728997;5046.545810877002;5048.570871475929;5095.668781529226;4491.416115904977;4522.932156017662;4656.092062047868;4669.463011753658;4721.57505824474;5091.643584949092;5116.8209112681625;5126.641135120581;5127.333446651912;5134.2812006319145;4897.877553061202;4937.136001199776;4937.7777999990085;4941.135301322326;4997.625178111656;4659.5573420525;4664.300354946718;4997.0505603935135;5005.6996580205305;5045.192769156917;4670.486246512881;4860.927086093711;4953.6532442729385;4969.254611808257;5017.84946451607;4944.703317800943;4957.206846904478;4957.950420495821;4964.528369804935;5011.072951503984;4175.039740859619;4176.331786914079;4185;4188.120494696148;4226.387173859773;3590.7666001709804;3630.582483014487;3632.8183590820354;3645.143391303042;3647.215848592565;4292.806823692941;4294;4295.055087880662;4323.610875021263;4327.480702315742;4958.181899986534;4961.255811628284;4963.925541116886;4966.230234313687;5013.548780609763;4178.811953462041;4183.6653067754505;4195.8741237762915;4220.725652832556;4289.120730250291;4436.157130145262;4453.665975051884;4485.349624304457;4505.121501307279;4507.774611269423;4243.342281946303;4247.851325203603;4248.702590818737;4250.659947204278;4290.334998075366;4812.927806082842;4916;4916.164252077084;4924.606031517398;4927.655064145475;4192.958070419257;4228.344606585984;4242.7242229255;4266.168097221012;4288.463942007249;4940.6788558743565;4943.505649435172;4946.579540739078;4946.727929963887;4988.975055124701;4943.480934501826;5006.123928312603;5006.424261210008;5009.7244651544515;5056.595472362275;4710.317004034464;4743.501932297059;4870.050340183772;4872.658913875995;4909.9018019640125;4912.828051018198;4917.164082105979;4922.827701030446;4924.236743304794;4963.032208719265;4557.248054071174;4622.51463596331;4632.559906808848;4682.578567928903;4902.901941961212;4704.623630109514;4747.216709242936;4756.6908150970075;4758.5241475852135;4760.0241950399395;4644.674872759009;4645.442546894395;4656.534346565317;4715.599174070106;4750.287456881357 07:16:37 INFO - PROCESS | 28220 | |1;ext.html;527.6754795800582;555.2615022020713;566.6260268222974;570.8829689913565;589.3870374810198;33754.99999999997;35522.46716299254;35578.466323005145;38132.61867381325;38179.42730859039;39805;40020.39969400461;40101.79949100257;40156.19687606246;40204.39693404601;7516.285952834472;7553;7682.6158692065455;7694.807629809272;7700.4609677322605;7485.363744081759;9760;10010.949945250264;10020.89979100207;10306.330088544259;10033.548490317917;10079.294449388546;10106.949465252701;10113.241506886976;10116.140128089084;10030.247731420173;10091.545880435398;10096.091351778301;10106.64626738068;10107.949460252688;9665.661701840401;9710.660126895595;9738.951305243429;9740.123388894963;9758.462799672065;37385.81307093447;37824;37863.62136378628;37873.05317367088;37922;3617.963820361789;3724.5344331958504;3727.4967879336214;3749.418840079792;3773.754705944132;28006.2998425041;28029.719702802915;28413.57379639307;28721.56917646237;28908.277293067633;3494.930101397958;3500.879718490084;3529.541159649255;3595.8921232363073;3605.7115430765475;235977;237187;237687;238787;238958;51459.742701287;51735.22397164046;51807.48192518027;51807.48192518102;51839.74080129575;55557.72221138868;55596.16605750836;55621.44378556163;55639.443605564236;55644.44355556393;12804.423800928795;13329.600111996655;13333.066685331934;13336.799948000787;13340.866591334157;8886.111388861062;9144.222741067084;10241.948790256001;10298.948505257425;10357.533910974023;16312.939658922132;16676.74984875228;16796.748048779278;16827.158642067847;16870.240839162267;5784.971075144597;5855.151003104526;5876.353601103875;5966.433188847052;6046.516278697693;755.2862544895131;757.9279968402993;765.9693612255559;773.7330620935768;794.0550744613892;26040.609390859154;27067.91728330884;27241.727582724314;27347;27581;941.3975055964188;949.7720547068653;961.2838435365697;976.8583555384572;1089.9863127291537;14034.649133771738;14455.27723613815;14523.709525809425;14651.413943442356;14744.483943061941;322980;324036;324101;324403;324759;48123;48175.5182448178;48224.517754822;48266.03467930622;48556.5144348552;1171.4084387384487;1182.9053675705923;1215.5380955236953;1219.195331081482;1222.3643705273387;24126.701894934606;24542.386440339134;25880.094196703027;25917.74082259153;26274;39597.2080558393;41087.794561027;41092;41099;41155.58844411637;224727;225494;225535;226499;226737;31070.22324441907;31883.36233275368;35010.29979400449;39226.41160382539;39462.237643364686;35485.82257088698;36024.8198759015;39339.409908850816;39507.802460987514;40343.596564033985;29078.27304317409;29194.854025730587;29405.705942940298;29460.34280581839;29941.850290748407;29154;29918.85040574783;30126.397472050874;30171;30552.388952221274;29078;29328.85335573394;29341;29423.411531769674;29466.852665736533;25922.48155036851;26597;27305;27457.588136178372;27514.17457476199;21277.78722212758;21470.248541300978;21561.784382156606;21591.676124857826;21621.783782161976 07:16:37 INFO - PROCESS | 28220 | |2;jquery.html;337.93917094922904;359.5092698466594;367.3406235806727;370.5201763715988;394.08375526899965;12733.299668518228;12815.487380504781;13484.932575337121;13788.379522921468;16814.32742690291;16468.752968705478;16820.32718691251;16952.576185595368;16967;17052.744208836877;4984.526469985363;5151.6908985460805;5374.381946076212;5384.380796208447;5425.810096646618;3544.503769472276;5255.421903590602;5280.049591073605;5306.522412982831;5314.867128321785;3605.4772058051567;3696.2237930034726;3956.76259424434;5862.912056319158;5926.762929482816;5874.148248503986;5909.704514774266;5920.644761314335;5924.081767326072;5929.614575052651;5059.06407314648;5133.178691409356;5145.176771716508;5158.097332966716;5165.974170129163;10807.83788243177;10987.175961802897;11006.064484518745;15480;19879.80120198794;2246.809021233197;2439.792617627486;2469.160485434943;2469.77772000519;2508.761667641571;8704.390692651517;8891.110888911122;8944.418612790148;9089.590968406437;9509.524523773784;1689.1047744695331;1749.3177660712333;1787.3833527433014;1805.5666640006305;1942.7960064193198;61455.69272153655;64110.03834942526;64462.033069503996;64595.35404645988;68251.65874170647;9218.81562368749;9284.814303713887;9452.527373631428;9713.951430242803;9741.659041933499;12687.302198378993;12703.745925081446;12716.364181790874;12719.173253738478;12720.109592328634;6497.805065848032;6583.9012414813815;6761.594304341656;6776.220734615484;6827.726890924308;6315.55791094619;6317.715702793385;6335.968320158369;6487.805365839033;6490.286068532458;3985.2228815381304;4041.211963667057;4043.2613975990607;4122.690798190148;4427.734335939854;1765.1086201468434;1776.5025792778042;1800.4418630224673;1826.5524946387955;1833.9633207335778;787.4055088408329;788.2905385153408;793.2662287384146;812;817.7832874288318;15215.847841521443;15808.52574422769;16710;17111.486655400357;17262.482125536255;774.0865778381564;795.2167115391335;798.9480683755537;810.1817164663732;810.9067457242375;9291.72124836256;9706.660266890625;9707.174890134276;9711.174550163316;9855.45794981283;311427;315632;316055;317718;319645;66821.66589167023;66934.66532667403;67215.66392168106;67336;68895;902.4585248850638;903.8282726281985;933.0669330669331;934.1872570863393;934.3879758758025;14338.928305358406;14524.419023238952;14637.341319640429;14829.480968166063;15264.618384540476;31635.84182079075;32237;32333.838330809136;34253.31493370069;36247.818760906026;42360.94097647583;45388.773056135826;46018.30972535348;46183;47452.76273618748;6864.965675171592;7134.750283740044;7297.087864016998;7746.845063098819;7996.320312773247;10262.846057309296;11609;11863.822042669539;12254.019678425526;12295;9792.167665748491;9922.553485093043;10008.999100090225;10202.897971020491;10556;9954.303198776017;10236.33463824849;10435.37387756737;10519.105876000625;10774.892251077388;10258.281920265808;10275;10457.215708822021;10674.679759606914;10674.786504270027;6996.615186164606;7063.434925206074;7140.321669441395;7184.8922266165;7195.820104497429;8672.436291641023;10582.312149710553;10587.788244235226;10908.345499269752;10995.395253260827 07:16:37 INFO - PROCESS | 28220 | |3;mootools.html;1285.0683254640387;1297.8183054372387;1308.2412200923463;1311.5606271898907;1314.6976195475047;6721.092652491912;7097.2902709729005;7117.501774875761;7119.786406407816;7125.85748285034;6119.449249567538;6340.397662222082;6681;6785.321467853212;6831.941049137379;2071.689246613009;2112.968305475419;2114.0486780948636;2114.6405111131144;2116.343933380649;2114.2600089968464;2153.752318483371;2159.492519257981;2166.523364859728;2167.2847960173103;1644.629958259394;1695.5845817774662;2010.88940108294;2062.1957436599737;2083.3229200509895;2051.7435320584927;2062.0205402433876;2064.4838790302424;2066.5143691232624;2067.4934641012896;1869.8223668751448;1889.6220755848747;1895.5261184703825;1899.3921944977612;1900.9049547522707;6765.695543700545;7025.473089518307;7144.928550714479;7144.964275178643;7145.035420218256;4295.828166873322;4419.447569053868;4441.045175287329;4443.866683999485;4444.711093778894;2776.1671498550354;2871.583620375034;2918.722721341469;2940.8529573521237;2953.3354995126138;1076.7308172956762;1096.2435919215716;1138.390960835957;1140.0594509529672;1146.2950285574311;9194.08059194082;9233.215176709988;9245;9257.675981340688;9276.16514513697;3736.9439458408146;3963.147923196469;4026.275270451288;4043.6158564936286;4048.8987775305854;8030.799230019179;8033.879491807627;8037.035555733232;8038.236367545191;8043.7989050273045;4373.453318335208;4423.823047078081;4431.0694754102;4439.977800110979;4440.08978159483;3584.802835844054;3696.7800625793425;3979.7811120388656;4049.7367671101283;4056;3343.097363711784;3362.4620060790157;3492.7031202347575;3493.63316851732;3511.5259439975275;1172.9648110556698;1199.964001079969;1201.8077107662907;1205.6202296276645;1216.2033867816594;836.3727204596553;838.4508147163617;847.317909083194;865.9523726194993;871.6818361298207;4742.146413645577;4870.6103511718975;4909.852704418873;4997.400311962588;5049.545540901337;513.8741008452953;521.0568870344688;528.5480913818707;529.1058111791061;532.6457905492881;3077.6768439313996;3105.5186446100893;3117.3297740985795;3167.889123880653;3217.089050095931;8187.672493100209;8456.323494120456;8541.572921353907;8555.957220213984;8563.314934805201;8516.148385161558;8538;8538.87191692125;8541.359398045171;8546.871796923051;6499.2850786413455;6542.803715888435;6629.303923088103;6727.764528241586;6728.360805723546;4800.423949126127;4825.10735513931;4875.219964805614;4875.7074575525585;4935.75321233944;7705.30652241301;7728.961355193188;7752.14726380109;7819.100803407681;7867.84264314722;7833.960830195812;7907.762767116996;7929.444938854225;7936.166702496154;8005.119436861824;5480.890382192413;5617.4101719320515;6156.984097623842;6259.718312675849;6264;6822.761203357859;6861.073755043205;6908.896366554606;6910.274421185904;6917.13535808024;6037.15479832815;6177.752889884534;6251.468625166912;6301.40136687014;6334.683265836782;5994.490468310242;6121.969390153021;6129.540284478771;6132.693365331805;6135.570510064431;5542.725173210104;5696.060150075191;5696.515796157373;5697.6296540724725;5699.059655156852;4022.7586344819406;4053.250148722496;4056.675465962775;4145.564715704928;4202.936955945602;3743.213925075656;3756.6619004289746;3777.112378591084;3782.0922978485514;3876.341022026206 07:16:37 INFO - PROCESS | 28220 | |4;prototype.html;337.65390474763365;340.11400302212735;352.1214569648726;353.0291697830965;355.39582709394034;4756.2865570164495;4758.191107511727;4765.547273009063;4772.639797657668;4797.376341075664;4728.645351598635;4737.597304229136;4738.69198502098;4742.928856067162;4745.406824146981;3601.2077342984503;3712.1647629283466;3728.2170744143764;3765.265773174232;3771.6416940390754;3793.4309853522054;3812.370958791796;3813.3517302058717;3819.5798462169278;3820.465134881119;3777.5466943966762;3778.9622103779025;3789.7347185697013;3790.8248442982763;3798.6771124454453;3619.6380361963857;3665.2119794244363;3729.254149170163;3770.6425686753023;3771.208046310278;3400.523926650271;3406.982965085159;3411.761176717631;3415.624281329052;3420.3843308204514;4580.839670611546;4594.287885377772;4599.770011499411;4612.607928326062;4616.953830461686;3957.762534247954;4147.7926103695;4277.272863613193;4285.250081235771;4335.544767799367;4921.384826896638;4938.604911607063;4938.827141050082;4941.703497790144;4946.802127914879;3497.6327485613897;3504.7196224301993;3507.438809790421;3525.7531972761917;3527.4708793680898;4980.153373926441;5078.663814645268;5092.7453627318855;5122.282880396748;5160.380754309469;3539.2567560812518;3566.928661426809;3569.589497207802;3576.2311103112957;3578.7315951303235;3610.4042832932273;3610.656987586175;3613.7713177519768;3617.7105831533413;3632.2372301816386;4118.364246881998;4154.1068670236045;4156.916861662749;4159.521655009713;4161.97919010403;4847;4955.876103097451;4977.601791856643;4977.751112444364;4988.176950803077;1220.3464305865602;1222.0712258683463;1226.2642414551376;1227.8096894981293;1236.727919857648;790.3084800799301;808.1837344282317;826.4338927834452;841.3437518735396;841.9579021048924;4269.252880745857;4365;4371.497277813029;4381.978090109529;4382;5088.185890257541;5091.134507133796;5107.438181799999;5135.306733590992;5150;4262;4371.846985355497;4392.2752745797225;4394.340848872631;4399.318105693623;2596.5326241276375;2625.9080932167662;2628.448025914541;2629.5924131759607;2631.1448779146854;4222.978885105555;4263.8081286342185;4265.168292183057;4268.530461649216;4271.10306835568;4875.7074575525585;5013.047520971004;5019.84940451787;5022.748862556858;5023.522765337287;4237.703360764717;4272.6795490338345;4272.700910936204;4273.4530339817875;4276.657867370541;4915.6067514598035;4941.75291235444;4957.446914838789;4958;4959.222835212293;4861.246506791453;4871.244957031666;4872.4153101628035;4917.680350777331;4919.3604831371695;4167.270727622593;4399.934000990052;4411.669124815716;4428.313611390111;4429.2027435062;3598.4962105305804;3610.548681414823;3621.1852333225866;3626.1478552539606;3627.147620309278;5130.79476820923;5136.356365963005;5137.255098010843;5140.331756871583;5146.614003949644;4748.88127796794;4941.6293777966075;4981.011393164217;4995.776879288682;5006.098902197639;4947.678400903929;4976.576990955809;4989.476105009067;4990.176620857663;4993.201087825931;4930.112579735539;4931.48219436954;4941.258811178352;4942.629302802232;4944.307796908363;4873.269009648439;4989;5016.147254966591;5041.8487445376695;5042;4935.629827763004;4937.6426577164175;4945.876353091057;4949.133901567283;4956.677815941952 07:16:37 INFO - PROCESS | 28220 | |5;yui.html;669.3741351836037;681.1281559603706;731.2395109086547;746.2127455534412;750.197288900876;13364.465421383145;14216.644583885382;14235.92882035591;14239.71520569588;14242.359093840776;13565.25391103489;13613.591592252224;13632.113912595674;13646.454141834314;13668.863311366884;652.7584793626353;686.7356067913864;792.3819420851717;812.0823469479479;824.983500329993;819.5246756880995;821.6466919224731;821.9630116644736;822.0464261456711;822.6956026270288;857.9485230886166;859.9269062129727;861.4831101339178;862.2024627219828;862.2326129744501;702.5573888450294;726.2265687043282;835.5237514616671;862.9525376104311;869.1221865915408;633.2654121219409;633.3856159525253;633.6324931539696;633.6958260035162;634.4068296143075;13232.86767132326;13579.660508487268;13652.522161724291;13658.385372658255;13661.316934153352;11653.184277100607;12013.339266340348;12135.817962730565;12599;12749.936250318782;12212.145149839514;12238.326892020936;12303.200291980993;12504.687382815411;12648.873511264861;4208.579142085798;4209.473815773028;4245.660347172219;4261;4274.444322238121;62934.37065629331;64024.679876600785;64084.35915640877;64190;65667.99999999952;10149.492525373702;10180.898191017995;10314.948425257826;10446.843297350546;10537.209709271836;17605.823941760675;17664.205110770046;17789.288428462718;17832.732509012374;17943.641127177645;6556.901646475307;6588.40704336612;6629.86740265192;6704.564203326768;6731.831704207434;3586.4978902953085;3678.4482327651067;3690.612485689018;3696.8890933272046;3768.8304026318883;2648.3246772073;2696.4472283182295;2710.417260289047;2714.280715610365;2721.986390068037;450.8264318237502;454.1190091223017;462.3596319098006;464.55634868700986;465.57167405986576;571.6455797405551;575.1602660116278;576.1415490918585;586.8620874094585;594.9970250148722;7458.701651933862;7615.352695020985;8110.270075693216;8188.672453101928;8374.078851326349;559.6502186133666;590.7814108779693;594.2334388638608;596.3562632316542;610.2036841921336;3578.946315805265;3682.1899182179877;3697.7041836653543;3738.4953031340965;3789.0906182515996;66669.33330666632;67671.32328676748;67906.98139527912;70726.292737073;71019;41029.179416411505;43569.34645980313;46410;52007.47992520102;56850.746417894;47295.5270447298;48530.27204591934;49027.50972490301;51591.226131608055;51598.48401515937;8226.78767328228;8733.08302628215;8745.781355466164;8745.868811967699;8966.237869781142;34095.65904340925;35012.64987350094;35937.28125437529;36263;36681.44977825281;43103;43130;43255.567444326414;44008.559914400445;44249;11006.614768483065;11160.218784684994;11193.216474846682;11212.55149793999;11264.324140551593;12088.879111208775;12288.81566776517;12457.439415226156;12549.184303020274;12849.935750321189;11729.237599556001;12275.877241227474;12291.75416491683;12371.69070773238;12811.295378753885;10486.895131048592;11636.418179090842;11638.88361116378;11918.940405297919;12249.69375765613;10563.735906602396;11118.555257789598;11168.385738784445;11464.369459679798;11491.942540287246;10131.898681013095;10416.739581510523;10427.322224055411;10712.946435267773;10728.946355268174;9388.624455021723;9564.426134431957;10286.485675716334;10303;10374.481275936023 07:16:37 INFO - PROCESS | 28220 | __end_tp_report 07:16:37 INFO - PROCESS | 28220 | __start_cc_report 07:16:37 INFO - PROCESS | 28220 | _x_x_mozilla_cycle_collect,1938 07:16:37 INFO - PROCESS | 28220 | __end_cc_report 07:16:37 INFO - PROCESS | 28220 | __startTimestamp1483456597507__endTimestamp 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | ------- Summary: start ------- 07:16:37 INFO - PROCESS | 28220 | Number of tests: 6 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | [#0] dojo.html Cycles:165 Average:4556.66 Median:4659.56 stddev:494.83 (10.6%) stddev-sans-first:470.19 07:16:37 INFO - PROCESS | 28220 | Values: 2532.9 2553.7 2570.7 2602.3 2609.6 4447.9 4491.2 4656.3 4677.0 4680.2 4505.6 4670.7 4698.4 4735.4 4752.2 4274.7 4321.3 4350.7 4367.4 4389.0 3946.0 4310.6 4381.7 4414.1 4456.6 4174.4 4316.9 4326.3 4384.6 4390.4 4227.9 4268.7 4270.7 4277.9 4284.2 4217.1 4231.0 4238.8 4243.2 4247.3 4595.5 4595.9 4596.9 4629.7 4659.8 4963.3 4970.5 4976.6 5021.5 5024.0 5025.9 5034.0 5046.5 5048.6 5095.7 4491.4 4522.9 4656.1 4669.5 4721.6 5091.6 5116.8 5126.6 5127.3 5134.3 4897.9 4937.1 4937.8 4941.1 4997.6 4659.6 4664.3 4997.1 5005.7 5045.2 4670.5 4860.9 4953.7 4969.3 5017.8 4944.7 4957.2 4958.0 4964.5 5011.1 4175.0 4176.3 4185.0 4188.1 4226.4 3590.8 3630.6 3632.8 3645.1 3647.2 4292.8 4294.0 4295.1 4323.6 4327.5 4958.2 4961.3 4963.9 4966.2 5013.5 4178.8 4183.7 4195.9 4220.7 4289.1 4436.2 4453.7 4485.3 4505.1 4507.8 4243.3 4247.9 4248.7 4250.7 4290.3 4812.9 4916.0 4916.2 4924.6 4927.7 4193.0 4228.3 4242.7 4266.2 4288.5 4940.7 4943.5 4946.6 4946.7 4989.0 4943.5 5006.1 5006.4 5009.7 5056.6 4710.3 4743.5 4870.1 4872.7 4909.9 4912.8 4917.2 4922.8 4924.2 4963.0 4557.2 4622.5 4632.6 4682.6 4902.9 4704.6 4747.2 4756.7 4758.5 4760.0 4644.7 4645.4 4656.5 4715.6 4750.3 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | [#1] ext.html Cycles:180 Average:41874.01 Median:324068.50 stddev:69613.20 (21.5%) stddev-sans-first:69739.27 07:16:37 INFO - PROCESS | 28220 | Values: 527.7 555.3 566.6 570.9 589.4 33755.0 35522.5 35578.5 38132.6 38179.4 39805.0 40020.4 40101.8 40156.2 40204.4 7516.3 7553.0 7682.6 7694.8 7700.5 7485.4 9760.0 10010.9 10020.9 10306.3 10033.5 10079.3 10106.9 10113.2 10116.1 10030.2 10091.5 10096.1 10106.6 10107.9 9665.7 9710.7 9739.0 9740.1 9758.5 37385.8 37824.0 37863.6 37873.1 37922.0 3618.0 3724.5 3727.5 3749.4 3773.8 28006.3 28029.7 28413.6 28721.6 28908.3 3494.9 3500.9 3529.5 3595.9 3605.7 235977.0 237187.0 237687.0 238787.0 238958.0 51459.7 51735.2 51807.5 51807.5 51839.7 55557.7 55596.2 55621.4 55639.4 55644.4 12804.4 13329.6 13333.1 13336.8 13340.9 8886.1 9144.2 10241.9 10298.9 10357.5 16312.9 16676.7 16796.7 16827.2 16870.2 5785.0 5855.2 5876.4 5966.4 6046.5 755.3 757.9 766.0 773.7 794.1 26040.6 27067.9 27241.7 27347.0 27581.0 941.4 949.8 961.3 976.9 1090.0 14034.6 14455.3 14523.7 14651.4 14744.5 322980.0 324036.0 324101.0 324403.0 324759.0 48123.0 48175.5 48224.5 48266.0 48556.5 1171.4 1182.9 1215.5 1219.2 1222.4 24126.7 24542.4 25880.1 25917.7 26274.0 39597.2 41087.8 41092.0 41099.0 41155.6 224727.0 225494.0 225535.0 226499.0 226737.0 31070.2 31883.4 35010.3 39226.4 39462.2 35485.8 36024.8 39339.4 39507.8 40343.6 29078.3 29194.9 29405.7 29460.3 29941.9 29154.0 29918.9 30126.4 30171.0 30552.4 29078.0 29328.9 29341.0 29423.4 29466.9 25922.5 26597.0 27305.0 27457.6 27514.2 21277.8 21470.2 21561.8 21591.7 21621.8 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | [#2] jquery.html Cycles:180 Average:21189.08 Median:24908.25 stddev:52369.89 (210.3%) stddev-sans-first:52493.40 07:16:37 INFO - PROCESS | 28220 | Values: 337.9 359.5 367.3 370.5 394.1 12733.3 12815.5 13484.9 13788.4 16814.3 16468.8 16820.3 16952.6 16967.0 17052.7 4984.5 5151.7 5374.4 5384.4 5425.8 3544.5 5255.4 5280.0 5306.5 5314.9 3605.5 3696.2 3956.8 5862.9 5926.8 5874.1 5909.7 5920.6 5924.1 5929.6 5059.1 5133.2 5145.2 5158.1 5166.0 10807.8 10987.2 11006.1 15480.0 19879.8 2246.8 2439.8 2469.2 2469.8 2508.8 8704.4 8891.1 8944.4 9089.6 9509.5 1689.1 1749.3 1787.4 1805.6 1942.8 61455.7 64110.0 64462.0 64595.4 68251.7 9218.8 9284.8 9452.5 9714.0 9741.7 12687.3 12703.7 12716.4 12719.2 12720.1 6497.8 6583.9 6761.6 6776.2 6827.7 6315.6 6317.7 6336.0 6487.8 6490.3 3985.2 4041.2 4043.3 4122.7 4427.7 1765.1 1776.5 1800.4 1826.6 1834.0 787.4 788.3 793.3 812.0 817.8 15215.8 15808.5 16710.0 17111.5 17262.5 774.1 795.2 798.9 810.2 810.9 9291.7 9706.7 9707.2 9711.2 9855.5 311427.0 315632.0 316055.0 317718.0 319645.0 66821.7 66934.7 67215.7 67336.0 68895.0 902.5 903.8 933.1 934.2 934.4 14338.9 14524.4 14637.3 14829.5 15264.6 31635.8 32237.0 32333.8 34253.3 36247.8 42360.9 45388.8 46018.3 46183.0 47452.8 6865.0 7134.8 7297.1 7746.8 7996.3 10262.8 11609.0 11863.8 12254.0 12295.0 9792.2 9922.6 10009.0 10202.9 10556.0 9954.3 10236.3 10435.4 10519.1 10774.9 10258.3 10275.0 10457.2 10674.7 10674.8 6996.6 7063.4 7140.3 7184.9 7195.8 8672.4 10582.3 10587.8 10908.3 10995.4 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | [#3] mootools.html Cycles:180 Average:4638.01 Median:4892.78 stddev:2507.56 (51.3%) stddev-sans-first:2501.93 07:16:37 INFO - PROCESS | 28220 | Values: 1285.1 1297.8 1308.2 1311.6 1314.7 6721.1 7097.3 7117.5 7119.8 7125.9 6119.4 6340.4 6681.0 6785.3 6831.9 2071.7 2113.0 2114.0 2114.6 2116.3 2114.3 2153.8 2159.5 2166.5 2167.3 1644.6 1695.6 2010.9 2062.2 2083.3 2051.7 2062.0 2064.5 2066.5 2067.5 1869.8 1889.6 1895.5 1899.4 1900.9 6765.7 7025.5 7144.9 7145.0 7145.0 4295.8 4419.4 4441.0 4443.9 4444.7 2776.2 2871.6 2918.7 2940.9 2953.3 1076.7 1096.2 1138.4 1140.1 1146.3 9194.1 9233.2 9245.0 9257.7 9276.2 3736.9 3963.1 4026.3 4043.6 4048.9 8030.8 8033.9 8037.0 8038.2 8043.8 4373.5 4423.8 4431.1 4440.0 4440.1 3584.8 3696.8 3979.8 4049.7 4056.0 3343.1 3362.5 3492.7 3493.6 3511.5 1173.0 1200.0 1201.8 1205.6 1216.2 836.4 838.5 847.3 866.0 871.7 4742.1 4870.6 4909.9 4997.4 5049.5 513.9 521.1 528.5 529.1 532.6 3077.7 3105.5 3117.3 3167.9 3217.1 8187.7 8456.3 8541.6 8556.0 8563.3 8516.1 8538.0 8538.9 8541.4 8546.9 6499.3 6542.8 6629.3 6727.8 6728.4 4800.4 4825.1 4875.2 4875.7 4935.8 7705.3 7729.0 7752.1 7819.1 7867.8 7834.0 7907.8 7929.4 7936.2 8005.1 5480.9 5617.4 6157.0 6259.7 6264.0 6822.8 6861.1 6908.9 6910.3 6917.1 6037.2 6177.8 6251.5 6301.4 6334.7 5994.5 6122.0 6129.5 6132.7 6135.6 5542.7 5696.1 5696.5 5697.6 5699.1 4022.8 4053.3 4056.7 4145.6 4202.9 3743.2 3756.7 3777.1 3782.1 3876.3 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | [#4] prototype.html Cycles:180 Average:4074.44 Median:4399.63 stddev:1170.64 (26.6%) stddev-sans-first:1139.83 07:16:37 INFO - PROCESS | 28220 | Values: 337.7 340.1 352.1 353.0 355.4 4756.3 4758.2 4765.5 4772.6 4797.4 4728.6 4737.6 4738.7 4742.9 4745.4 3601.2 3712.2 3728.2 3765.3 3771.6 3793.4 3812.4 3813.4 3819.6 3820.5 3777.5 3779.0 3789.7 3790.8 3798.7 3619.6 3665.2 3729.3 3770.6 3771.2 3400.5 3407.0 3411.8 3415.6 3420.4 4580.8 4594.3 4599.8 4612.6 4617.0 3957.8 4147.8 4277.3 4285.3 4335.5 4921.4 4938.6 4938.8 4941.7 4946.8 3497.6 3504.7 3507.4 3525.8 3527.5 4980.2 5078.7 5092.7 5122.3 5160.4 3539.3 3566.9 3569.6 3576.2 3578.7 3610.4 3610.7 3613.8 3617.7 3632.2 4118.4 4154.1 4156.9 4159.5 4162.0 4847.0 4955.9 4977.6 4977.8 4988.2 1220.3 1222.1 1226.3 1227.8 1236.7 790.3 808.2 826.4 841.3 842.0 4269.3 4365.0 4371.5 4382.0 4382.0 5088.2 5091.1 5107.4 5135.3 5150.0 4262.0 4371.8 4392.3 4394.3 4399.3 2596.5 2625.9 2628.4 2629.6 2631.1 4223.0 4263.8 4265.2 4268.5 4271.1 4875.7 5013.0 5019.8 5022.7 5023.5 4237.7 4272.7 4272.7 4273.5 4276.7 4915.6 4941.8 4957.4 4958.0 4959.2 4861.2 4871.2 4872.4 4917.7 4919.4 4167.3 4399.9 4411.7 4428.3 4429.2 3598.5 3610.5 3621.2 3626.1 3627.1 5130.8 5136.4 5137.3 5140.3 5146.6 4748.9 4941.6 4981.0 4995.8 5006.1 4947.7 4976.6 4989.5 4990.2 4993.2 4930.1 4931.5 4941.3 4942.6 4944.3 4873.3 4989.0 5016.1 5041.8 5042.0 4935.6 4937.6 4945.9 4949.1 4956.7 07:16:37 INFO - PROCESS | 28220 | 07:16:37 INFO - PROCESS | 28220 | [#5] yui.html Cycles:180 Average:14627.50 Median:4227.57 stddev:17961.30 (424.9%) stddev-sans-first:17981.10 07:16:37 INFO - PROCESS | 28220 | Values: 669.4 681.1 731.2 746.2 750.2 13364.5 14216.6 14235.9 14239.7 14242.4 13565.3 13613.6 13632.1 13646.5 13668.9 652.8 686.7 792.4 812.1 825.0 819.5 821.6 822.0 822.0 822.7 857.9 859.9 861.5 862.2 862.2 702.6 726.2 835.5 863.0 869.1 633.3 633.4 633.6 633.7 634.4 13232.9 13579.7 13652.5 13658.4 13661.3 11653.2 12013.3 12135.8 12599.0 12749.9 12212.1 12238.3 12303.2 12504.7 12648.9 4208.6 4209.5 4245.7 4261.0 4274.4 62934.4 64024.7 64084.4 64190.0 65668.0 10149.5 10180.9 10314.9 10446.8 10537.2 17605.8 17664.2 17789.3 17832.7 17943.6 6556.9 6588.4 6629.9 6704.6 6731.8 3586.5 3678.4 3690.6 3696.9 3768.8 2648.3 2696.4 2710.4 2714.3 2722.0 450.8 454.1 462.4 464.6 465.6 571.6 575.2 576.1 586.9 595.0 7458.7 7615.4 8110.3 8188.7 8374.1 559.7 590.8 594.2 596.4 610.2 3578.9 3682.2 3697.7 3738.5 3789.1 66669.3 67671.3 67907.0 70726.3 71019.0 41029.2 43569.3 46410.0 52007.5 56850.7 47295.5 48530.3 49027.5 51591.2 51598.5 8226.8 8733.1 8745.8 8745.9 8966.2 34095.7 35012.6 35937.3 36263.0 36681.4 43103.0 43130.0 43255.6 44008.6 44249.0 11006.6 11160.2 11193.2 11212.6 11264.3 12088.9 12288.8 12457.4 12549.2 12849.9 11729.2 12275.9 12291.8 12371.7 12811.3 10486.9 11636.4 11638.9 11918.9 12249.7 10563.7 11118.6 11168.4 11464.4 11491.9 10131.9 10416.7 10427.3 10712.9 10728.9 9388.6 9564.4 10286.5 10303.0 10374.5 07:16:37 INFO - PROCESS | 28220 | -------- Summary: end -------- 07:16:37 INFO - PROCESS | 28220 | 07:16:38 INFO - TEST-INFO | 28220: exit 0 07:16:38 INFO - TEST-OK | dromaeo_css | took 1120516ms 07:16:38 INFO - TEST-START | kraken 07:16:38 INFO - operating with platform_type : linux_ 07:16:38 INFO - Initialising browser for kraken test... 07:16:38 INFO - TEST-INFO | started process 28524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptNHwIh/profile http://localhost:60691/getInfo.html) 07:16:38 INFO - PROCESS | 28524 | 1483456598902 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:16:42 INFO - PROCESS | 28524 | __metrics Screen width/height:1600/1200 07:16:42 INFO - PROCESS | 28524 | colorDepth:24 07:16:42 INFO - PROCESS | 28524 | Browser inner width/height: 1024/697 07:16:42 INFO - PROCESS | 28524 | __metrics 07:16:43 INFO - PROCESS | 28524 | 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" 07:16:43 INFO - PROCESS | 28524 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:43 INFO - PROCESS | 28524 | console.error: PushService: 07:16:43 INFO - PROCESS | 28524 | stateChangeProcessEnqueue: Error transitioning state 07:16:43 INFO - PROCESS | 28524 | UnknownError 07:16:44 INFO - TEST-INFO | 28524: exit 0 07:16:44 INFO - Browser initialized. 07:16:44 INFO - Running cycle 1/1 for kraken test... 07:16:44 INFO - TEST-INFO | started process 28605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptNHwIh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:56 INFO - PROCESS | 28605 | RSS: Main: 151318528 07:16:56 INFO - PROCESS | 28605 | 07:16:58 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60691/tests/kraken/driver.html?testName=audio-beat-detection) 07:16:59 INFO - PROCESS | 28605 | RSS: Main: 205348864 07:16:59 INFO - PROCESS | 28605 | 07:17:02 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60691/tests/kraken/driver.html?testName=audio-dft) 07:17:03 INFO - PROCESS | 28605 | RSS: Main: 184856576 07:17:03 INFO - PROCESS | 28605 | 07:17:06 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60691/tests/kraken/driver.html?testName=audio-fft) 07:17:06 INFO - PROCESS | 28605 | RSS: Main: 266944512 07:17:06 INFO - PROCESS | 28605 | 07:17:09 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60691/tests/kraken/driver.html?testName=audio-oscillator) 07:17:09 INFO - PROCESS | 28605 | RSS: Main: 179417088 07:17:09 INFO - PROCESS | 28605 | 07:17:11 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60691/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:12 INFO - PROCESS | 28605 | RSS: Main: 182083584 07:17:12 INFO - PROCESS | 28605 | 07:17:15 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60691/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:16 INFO - PROCESS | 28605 | RSS: Main: 221323264 07:17:16 INFO - PROCESS | 28605 | 07:17:19 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60691/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:20 INFO - PROCESS | 28605 | RSS: Main: 221278208 07:17:20 INFO - PROCESS | 28605 | 07:17:23 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60691/tests/kraken/driver.html?testName=json-parse-financial) 07:17:23 INFO - PROCESS | 28605 | RSS: Main: 219582464 07:17:23 INFO - PROCESS | 28605 | 07:17:25 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60691/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:26 INFO - PROCESS | 28605 | RSS: Main: 182444032 07:17:26 INFO - PROCESS | 28605 | 07:17:27 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:28 INFO - PROCESS | 28605 | RSS: Main: 190529536 07:17:28 INFO - PROCESS | 28605 | 07:17:30 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:31 INFO - PROCESS | 28605 | RSS: Main: 197644288 07:17:31 INFO - PROCESS | 28605 | 07:17:34 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:34 INFO - PROCESS | 28605 | RSS: Main: 206913536 07:17:34 INFO - PROCESS | 28605 | 07:17:37 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:17:38 INFO - PROCESS | 28605 | RSS: Main: 203333632 07:17:38 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | Cycle 1(1): loaded http://localhost:60691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60691/tests/kraken/driver.html?testName=ai-astar) 07:17:40 INFO - PROCESS | 28605 | RSS: Main: 253800448 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | __start_tp_report 07:17:40 INFO - PROCESS | 28605 | _x_x_mozilla_page_load 07:17:40 INFO - PROCESS | 28605 | _x_x_mozilla_page_load_details 07:17:40 INFO - PROCESS | 28605 | |i|pagename|runs| 07:17:40 INFO - PROCESS | 28605 | |0;ai-astar;108;116;117;116;115;114;116;114;114;115 07:17:40 INFO - PROCESS | 28605 | |1;audio-beat-detection;159;126;131;170;136;133;128;127;151;128 07:17:40 INFO - PROCESS | 28605 | |2;audio-dft;161;162;162;163;162;162;161;163;160;161 07:17:40 INFO - PROCESS | 28605 | |3;audio-fft;77;77;77;108;77;77;77;77;91;78 07:17:40 INFO - PROCESS | 28605 | |4;audio-oscillator;85;86;108;86;85;85;99;86;86;109 07:17:40 INFO - PROCESS | 28605 | |5;imaging-gaussian-blur;118;119;118;118;117;117;117;117;117;118 07:17:40 INFO - PROCESS | 28605 | |6;imaging-darkroom;149;151;151;149;149;149;149;149;149;148 07:17:40 INFO - PROCESS | 28605 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 07:17:40 INFO - PROCESS | 28605 | |8;json-parse-financial;61;59;59;59;59;60;59;60;59;61 07:17:40 INFO - PROCESS | 28605 | |9;json-stringify-tinderbox;68;68;67;68;67;67;67;67;67;68 07:17:40 INFO - PROCESS | 28605 | |10;stanford-crypto-aes;84;84;84;86;85;88;86;97;85;96 07:17:40 INFO - PROCESS | 28605 | |11;stanford-crypto-ccm;136;137;141;134;141;132;133;133;176;145 07:17:40 INFO - PROCESS | 28605 | |12;stanford-crypto-pbkdf2;183;176;176;177;180;177;177;179;181;176 07:17:40 INFO - PROCESS | 28605 | |13;stanford-crypto-sha256-iterative;71;70;74;70;73;68;70;71;72;68 07:17:40 INFO - PROCESS | 28605 | __end_tp_report 07:17:40 INFO - PROCESS | 28605 | __start_cc_report 07:17:40 INFO - PROCESS | 28605 | _x_x_mozilla_cycle_collect,1775 07:17:40 INFO - PROCESS | 28605 | __end_cc_report 07:17:40 INFO - PROCESS | 28605 | __startTimestamp1483456660661__endTimestamp 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | ------- Summary: start ------- 07:17:40 INFO - PROCESS | 28605 | Number of tests: 14 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.50 stddev:2.51 (2.2%) stddev-sans-first:1.09 07:17:40 INFO - PROCESS | 28605 | Values: 108.0 116.0 117.0 116.0 115.0 114.0 116.0 114.0 114.0 115.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:134.50 stddev:15.52 (11.5%) stddev-sans-first:14.66 07:17:40 INFO - PROCESS | 28605 | Values: 159.0 126.0 131.0 170.0 136.0 133.0 128.0 127.0 151.0 128.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 07:17:40 INFO - PROCESS | 28605 | Values: 161.0 162.0 162.0 163.0 162.0 162.0 161.0 163.0 160.0 161.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:10.25 (13.3%) stddev-sans-first:10.74 07:17:40 INFO - PROCESS | 28605 | Values: 77.0 77.0 77.0 108.0 77.0 77.0 77.0 77.0 91.0 78.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:86.00 stddev:9.90 (11.5%) stddev-sans-first:10.22 07:17:40 INFO - PROCESS | 28605 | Values: 85.0 86.0 108.0 86.0 85.0 85.0 99.0 86.0 86.0 109.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:17:40 INFO - PROCESS | 28605 | Values: 118.0 119.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:17:40 INFO - PROCESS | 28605 | Values: 149.0 151.0 151.0 149.0 149.0 149.0 149.0 149.0 149.0 148.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:17:40 INFO - PROCESS | 28605 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 07:17:40 INFO - PROCESS | 28605 | Values: 61.0 59.0 59.0 59.0 59.0 60.0 59.0 60.0 59.0 61.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:17:40 INFO - PROCESS | 28605 | Values: 68.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.00 stddev:4.90 (5.7%) stddev-sans-first:5.04 07:17:40 INFO - PROCESS | 28605 | Values: 84.0 84.0 84.0 86.0 85.0 88.0 86.0 97.0 85.0 96.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.00 stddev:13.08 (9.4%) stddev-sans-first:13.76 07:17:40 INFO - PROCESS | 28605 | Values: 136.0 137.0 141.0 134.0 141.0 132.0 133.0 133.0 176.0 145.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:178.00 stddev:2.44 (1.4%) stddev-sans-first:1.87 07:17:40 INFO - PROCESS | 28605 | Values: 183.0 176.0 176.0 177.0 180.0 177.0 177.0 179.0 181.0 176.0 07:17:40 INFO - PROCESS | 28605 | 07:17:40 INFO - PROCESS | 28605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.95 (2.7%) stddev-sans-first:2.06 07:17:40 INFO - PROCESS | 28605 | Values: 71.0 70.0 74.0 70.0 73.0 68.0 70.0 71.0 72.0 68.0 07:17:40 INFO - PROCESS | 28605 | -------- Summary: end -------- 07:17:40 INFO - PROCESS | 28605 | 07:17:41 INFO - TEST-INFO | 28605: exit 0 07:17:41 INFO - TEST-OK | kraken | took 63468ms 07:17:41 INFO - SUITE-END | took 1183s 07:17:42 INFO - Completed test suite (00:19:44) 07:17:42 INFO - javascript benchmark 07:17:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2532.8606926619036, 2553.655256540367, 2570.678665166854, 2602.3364042169246, 2609.5824668053115, 4447.933281000779, 4491.214037543433, 4656.301554766783, 4677.041206552657, 4680.180968330541, 4505.57197066279, 4670.673052886299, 4698.3892094027815, 4735.408073990751, 4752.215884379073, 4274.7435153890865, 4321.330193819963, 4350.673699472536, 4367.410399596046, 4388.97805510972, 3945.960540394588, 4310.633596144332, 4381.737095774248, 4414.139242847646, 4456.621187199092, 4174.415581818548, 4316.892077698051, 4326.307790753464, 4384.627306678936, 4390.385346051556, 4227.91544169118, 4268.658507319407, 4270.679699022555, 4277.893052673677, 4284.164587905359, 4217.093324935154, 4231.0, 4238.766867822269, 4243.236217480852, 4247.277962746341, 4595.517470665565, 4595.9080818383445, 4596.931046034312, 4629.675922685414, 4659.836905708318, 4963.3299504566785, 4970.453250142481, 4976.601871850244, 5021.472745361721, 5024.045431368028, 5025.924611130836, 5034.043531728997, 5046.545810877002, 5048.570871475929, 5095.668781529226, 4491.416115904977, 4522.932156017662, 4656.092062047868, 4669.463011753658, 4721.57505824474, 5091.643584949092, 5116.8209112681625, 5126.641135120581, 5127.333446651912, 5134.2812006319145, 4897.877553061202, 4937.136001199776, 4937.7777999990085, 4941.135301322326, 4997.625178111656, 4659.5573420525, 4664.300354946718, 4997.0505603935135, 5005.6996580205305, 5045.192769156917, 4670.486246512881, 4860.927086093711, 4953.6532442729385, 4969.254611808257, 5017.84946451607, 4944.703317800943, 4957.206846904478, 4957.950420495821, 4964.528369804935, 5011.072951503984, 4175.039740859619, 4176.331786914079, 4185.0, 4188.120494696148, 4226.387173859773, 3590.7666001709804, 3630.582483014487, 3632.8183590820354, 3645.143391303042, 3647.215848592565, 4292.806823692941, 4294.0, 4295.055087880662, 4323.610875021263, 4327.480702315742, 4958.181899986534, 4961.255811628284, 4963.925541116886, 4966.230234313687, 5013.548780609763, 4178.811953462041, 4183.6653067754505, 4195.8741237762915, 4220.725652832556, 4289.120730250291, 4436.157130145262, 4453.665975051884, 4485.349624304457, 4505.121501307279, 4507.774611269423, 4243.342281946303, 4247.851325203603, 4248.702590818737, 4250.659947204278, 4290.334998075366, 4812.927806082842, 4916.0, 4916.164252077084, 4924.606031517398, 4927.655064145475, 4192.958070419257, 4228.344606585984, 4242.7242229255, 4266.168097221012, 4288.463942007249, 4940.6788558743565, 4943.505649435172, 4946.579540739078, 4946.727929963887, 4988.975055124701, 4943.480934501826, 5006.123928312603, 5006.424261210008, 5009.7244651544515, 5056.595472362275, 4710.317004034464, 4743.501932297059, 4870.050340183772, 4872.658913875995, 4909.9018019640125, 4912.828051018198, 4917.164082105979, 4922.827701030446, 4924.236743304794, 4963.032208719265, 4557.248054071174, 4622.51463596331, 4632.559906808848, 4682.578567928903, 4902.901941961212, 4704.623630109514, 4747.216709242936, 4756.6908150970075, 4758.5241475852135, 4760.0241950399395, 4644.674872759009, 4645.442546894395, 4656.534346565317, 4715.599174070106, 4750.287456881357], "value": 4524.687197702764, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.6754795800582, 555.2615022020713, 566.6260268222974, 570.8829689913565, 589.3870374810198, 33754.99999999997, 35522.46716299254, 35578.466323005145, 38132.61867381325, 38179.42730859039, 39805.0, 40020.39969400461, 40101.79949100257, 40156.19687606246, 40204.39693404601, 7516.285952834472, 7553.0, 7682.6158692065455, 7694.807629809272, 7700.4609677322605, 7485.363744081759, 9760.0, 10010.949945250264, 10020.89979100207, 10306.330088544259, 10033.548490317917, 10079.294449388546, 10106.949465252701, 10113.241506886976, 10116.140128089084, 10030.247731420173, 10091.545880435398, 10096.091351778301, 10106.64626738068, 10107.949460252688, 9665.661701840401, 9710.660126895595, 9738.951305243429, 9740.123388894963, 9758.462799672065, 37385.81307093447, 37824.0, 37863.62136378628, 37873.05317367088, 37922.0, 3617.963820361789, 3724.5344331958504, 3727.4967879336214, 3749.418840079792, 3773.754705944132, 28006.2998425041, 28029.719702802915, 28413.57379639307, 28721.56917646237, 28908.277293067633, 3494.930101397958, 3500.879718490084, 3529.541159649255, 3595.8921232363073, 3605.7115430765475, 235977.0, 237187.0, 237687.0, 238787.0, 238958.0, 51459.742701287, 51735.22397164046, 51807.48192518027, 51807.48192518102, 51839.74080129575, 55557.72221138868, 55596.16605750836, 55621.44378556163, 55639.443605564236, 55644.44355556393, 12804.423800928795, 13329.600111996655, 13333.066685331934, 13336.799948000787, 13340.866591334157, 8886.111388861062, 9144.222741067084, 10241.948790256001, 10298.948505257425, 10357.533910974023, 16312.939658922132, 16676.74984875228, 16796.748048779278, 16827.158642067847, 16870.240839162267, 5784.971075144597, 5855.151003104526, 5876.353601103875, 5966.433188847052, 6046.516278697693, 755.2862544895131, 757.9279968402993, 765.9693612255559, 773.7330620935768, 794.0550744613892, 26040.609390859154, 27067.91728330884, 27241.727582724314, 27347.0, 27581.0, 941.3975055964188, 949.7720547068653, 961.2838435365697, 976.8583555384572, 1089.9863127291537, 14034.649133771738, 14455.27723613815, 14523.709525809425, 14651.413943442356, 14744.483943061941, 322980.0, 324036.0, 324101.0, 324403.0, 324759.0, 48123.0, 48175.5182448178, 48224.517754822, 48266.03467930622, 48556.5144348552, 1171.4084387384487, 1182.9053675705923, 1215.5380955236953, 1219.195331081482, 1222.3643705273387, 24126.701894934606, 24542.386440339134, 25880.094196703027, 25917.74082259153, 26274.0, 39597.2080558393, 41087.794561027, 41092.0, 41099.0, 41155.58844411637, 224727.0, 225494.0, 225535.0, 226499.0, 226737.0, 31070.22324441907, 31883.36233275368, 35010.29979400449, 39226.41160382539, 39462.237643364686, 35485.82257088698, 36024.8198759015, 39339.409908850816, 39507.802460987514, 40343.596564033985, 29078.27304317409, 29194.854025730587, 29405.705942940298, 29460.34280581839, 29941.850290748407, 29154.0, 29918.85040574783, 30126.397472050874, 30171.0, 30552.388952221274, 29078.0, 29328.85335573394, 29341.0, 29423.411531769674, 29466.852665736533, 25922.48155036851, 26597.0, 27305.0, 27457.588136178372, 27514.17457476199, 21277.78722212758, 21470.248541300978, 21561.784382156606, 21591.676124857826, 21621.783782161976], "value": 16984.853909678637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.93917094922904, 359.5092698466594, 367.3406235806727, 370.5201763715988, 394.08375526899965, 12733.299668518228, 12815.487380504781, 13484.932575337121, 13788.379522921468, 16814.32742690291, 16468.752968705478, 16820.32718691251, 16952.576185595368, 16967.0, 17052.744208836877, 4984.526469985363, 5151.6908985460805, 5374.381946076212, 5384.380796208447, 5425.810096646618, 3544.503769472276, 5255.421903590602, 5280.049591073605, 5306.522412982831, 5314.867128321785, 3605.4772058051567, 3696.2237930034726, 3956.76259424434, 5862.912056319158, 5926.762929482816, 5874.148248503986, 5909.704514774266, 5920.644761314335, 5924.081767326072, 5929.614575052651, 5059.06407314648, 5133.178691409356, 5145.176771716508, 5158.097332966716, 5165.974170129163, 10807.83788243177, 10987.175961802897, 11006.064484518745, 15480.0, 19879.80120198794, 2246.809021233197, 2439.792617627486, 2469.160485434943, 2469.77772000519, 2508.761667641571, 8704.390692651517, 8891.110888911122, 8944.418612790148, 9089.590968406437, 9509.524523773784, 1689.1047744695331, 1749.3177660712333, 1787.3833527433014, 1805.5666640006305, 1942.7960064193198, 61455.69272153655, 64110.03834942526, 64462.033069503996, 64595.35404645988, 68251.65874170647, 9218.81562368749, 9284.814303713887, 9452.527373631428, 9713.951430242803, 9741.659041933499, 12687.302198378993, 12703.745925081446, 12716.364181790874, 12719.173253738478, 12720.109592328634, 6497.805065848032, 6583.9012414813815, 6761.594304341656, 6776.220734615484, 6827.726890924308, 6315.55791094619, 6317.715702793385, 6335.968320158369, 6487.805365839033, 6490.286068532458, 3985.2228815381304, 4041.211963667057, 4043.2613975990607, 4122.690798190148, 4427.734335939854, 1765.1086201468434, 1776.5025792778042, 1800.4418630224673, 1826.5524946387955, 1833.9633207335778, 787.4055088408329, 788.2905385153408, 793.2662287384146, 812.0, 817.7832874288318, 15215.847841521443, 15808.52574422769, 16710.0, 17111.486655400357, 17262.482125536255, 774.0865778381564, 795.2167115391335, 798.9480683755537, 810.1817164663732, 810.9067457242375, 9291.72124836256, 9706.660266890625, 9707.174890134276, 9711.174550163316, 9855.45794981283, 311427.0, 315632.0, 316055.0, 317718.0, 319645.0, 66821.66589167023, 66934.66532667403, 67215.66392168106, 67336.0, 68895.0, 902.4585248850638, 903.8282726281985, 933.0669330669331, 934.1872570863393, 934.3879758758025, 14338.928305358406, 14524.419023238952, 14637.341319640429, 14829.480968166063, 15264.618384540476, 31635.84182079075, 32237.0, 32333.838330809136, 34253.31493370069, 36247.818760906026, 42360.94097647583, 45388.773056135826, 46018.30972535348, 46183.0, 47452.76273618748, 6864.965675171592, 7134.750283740044, 7297.087864016998, 7746.845063098819, 7996.320312773247, 10262.846057309296, 11609.0, 11863.822042669539, 12254.019678425526, 12295.0, 9792.167665748491, 9922.553485093043, 10008.999100090225, 10202.897971020491, 10556.0, 9954.303198776017, 10236.33463824849, 10435.37387756737, 10519.105876000625, 10774.892251077388, 10258.281920265808, 10275.0, 10457.215708822021, 10674.679759606914, 10674.786504270027, 6996.615186164606, 7063.434925206074, 7140.321669441395, 7184.8922266165, 7195.820104497429, 8672.436291641023, 10582.312149710553, 10587.788244235226, 10908.345499269752, 10995.395253260827], "value": 7797.35320302393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.0683254640387, 1297.8183054372387, 1308.2412200923463, 1311.5606271898907, 1314.6976195475047, 6721.092652491912, 7097.2902709729005, 7117.501774875761, 7119.786406407816, 7125.85748285034, 6119.449249567538, 6340.397662222082, 6681.0, 6785.321467853212, 6831.941049137379, 2071.689246613009, 2112.968305475419, 2114.0486780948636, 2114.6405111131144, 2116.343933380649, 2114.2600089968464, 2153.752318483371, 2159.492519257981, 2166.523364859728, 2167.2847960173103, 1644.629958259394, 1695.5845817774662, 2010.88940108294, 2062.1957436599737, 2083.3229200509895, 2051.7435320584927, 2062.0205402433876, 2064.4838790302424, 2066.5143691232624, 2067.4934641012896, 1869.8223668751448, 1889.6220755848747, 1895.5261184703825, 1899.3921944977612, 1900.9049547522707, 6765.695543700545, 7025.473089518307, 7144.928550714479, 7144.964275178643, 7145.035420218256, 4295.828166873322, 4419.447569053868, 4441.045175287329, 4443.866683999485, 4444.711093778894, 2776.1671498550354, 2871.583620375034, 2918.722721341469, 2940.8529573521237, 2953.3354995126138, 1076.7308172956762, 1096.2435919215716, 1138.390960835957, 1140.0594509529672, 1146.2950285574311, 9194.08059194082, 9233.215176709988, 9245.0, 9257.675981340688, 9276.16514513697, 3736.9439458408146, 3963.147923196469, 4026.275270451288, 4043.6158564936286, 4048.8987775305854, 8030.799230019179, 8033.879491807627, 8037.035555733232, 8038.236367545191, 8043.7989050273045, 4373.453318335208, 4423.823047078081, 4431.0694754102, 4439.977800110979, 4440.08978159483, 3584.802835844054, 3696.7800625793425, 3979.7811120388656, 4049.7367671101283, 4056.0, 3343.097363711784, 3362.4620060790157, 3492.7031202347575, 3493.63316851732, 3511.5259439975275, 1172.9648110556698, 1199.964001079969, 1201.8077107662907, 1205.6202296276645, 1216.2033867816594, 836.3727204596553, 838.4508147163617, 847.317909083194, 865.9523726194993, 871.6818361298207, 4742.146413645577, 4870.6103511718975, 4909.852704418873, 4997.400311962588, 5049.545540901337, 513.8741008452953, 521.0568870344688, 528.5480913818707, 529.1058111791061, 532.6457905492881, 3077.6768439313996, 3105.5186446100893, 3117.3297740985795, 3167.889123880653, 3217.089050095931, 8187.672493100209, 8456.323494120456, 8541.572921353907, 8555.957220213984, 8563.314934805201, 8516.148385161558, 8538.0, 8538.87191692125, 8541.359398045171, 8546.871796923051, 6499.2850786413455, 6542.803715888435, 6629.303923088103, 6727.764528241586, 6728.360805723546, 4800.423949126127, 4825.10735513931, 4875.219964805614, 4875.7074575525585, 4935.75321233944, 7705.30652241301, 7728.961355193188, 7752.14726380109, 7819.100803407681, 7867.84264314722, 7833.960830195812, 7907.762767116996, 7929.444938854225, 7936.166702496154, 8005.119436861824, 5480.890382192413, 5617.4101719320515, 6156.984097623842, 6259.718312675849, 6264.0, 6822.761203357859, 6861.073755043205, 6908.896366554606, 6910.274421185904, 6917.13535808024, 6037.15479832815, 6177.752889884534, 6251.468625166912, 6301.40136687014, 6334.683265836782, 5994.490468310242, 6121.969390153021, 6129.540284478771, 6132.693365331805, 6135.570510064431, 5542.725173210104, 5696.060150075191, 5696.515796157373, 5697.6296540724725, 5699.059655156852, 4022.7586344819406, 4053.250148722496, 4056.675465962775, 4145.564715704928, 4202.936955945602, 3743.213925075656, 3756.6619004289746, 3777.112378591084, 3782.0922978485514, 3876.341022026206], "value": 3772.3454009876123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.65390474763365, 340.11400302212735, 352.1214569648726, 353.0291697830965, 355.39582709394034, 4756.2865570164495, 4758.191107511727, 4765.547273009063, 4772.639797657668, 4797.376341075664, 4728.645351598635, 4737.597304229136, 4738.69198502098, 4742.928856067162, 4745.406824146981, 3601.2077342984503, 3712.1647629283466, 3728.2170744143764, 3765.265773174232, 3771.6416940390754, 3793.4309853522054, 3812.370958791796, 3813.3517302058717, 3819.5798462169278, 3820.465134881119, 3777.5466943966762, 3778.9622103779025, 3789.7347185697013, 3790.8248442982763, 3798.6771124454453, 3619.6380361963857, 3665.2119794244363, 3729.254149170163, 3770.6425686753023, 3771.208046310278, 3400.523926650271, 3406.982965085159, 3411.761176717631, 3415.624281329052, 3420.3843308204514, 4580.839670611546, 4594.287885377772, 4599.770011499411, 4612.607928326062, 4616.953830461686, 3957.762534247954, 4147.7926103695, 4277.272863613193, 4285.250081235771, 4335.544767799367, 4921.384826896638, 4938.604911607063, 4938.827141050082, 4941.703497790144, 4946.802127914879, 3497.6327485613897, 3504.7196224301993, 3507.438809790421, 3525.7531972761917, 3527.4708793680898, 4980.153373926441, 5078.663814645268, 5092.7453627318855, 5122.282880396748, 5160.380754309469, 3539.2567560812518, 3566.928661426809, 3569.589497207802, 3576.2311103112957, 3578.7315951303235, 3610.4042832932273, 3610.656987586175, 3613.7713177519768, 3617.7105831533413, 3632.2372301816386, 4118.364246881998, 4154.1068670236045, 4156.916861662749, 4159.521655009713, 4161.97919010403, 4847.0, 4955.876103097451, 4977.601791856643, 4977.751112444364, 4988.176950803077, 1220.3464305865602, 1222.0712258683463, 1226.2642414551376, 1227.8096894981293, 1236.727919857648, 790.3084800799301, 808.1837344282317, 826.4338927834452, 841.3437518735396, 841.9579021048924, 4269.252880745857, 4365.0, 4371.497277813029, 4381.978090109529, 4382.0, 5088.185890257541, 5091.134507133796, 5107.438181799999, 5135.306733590992, 5150.0, 4262.0, 4371.846985355497, 4392.2752745797225, 4394.340848872631, 4399.318105693623, 2596.5326241276375, 2625.9080932167662, 2628.448025914541, 2629.5924131759607, 2631.1448779146854, 4222.978885105555, 4263.8081286342185, 4265.168292183057, 4268.530461649216, 4271.10306835568, 4875.7074575525585, 5013.047520971004, 5019.84940451787, 5022.748862556858, 5023.522765337287, 4237.703360764717, 4272.6795490338345, 4272.700910936204, 4273.4530339817875, 4276.657867370541, 4915.6067514598035, 4941.75291235444, 4957.446914838789, 4958.0, 4959.222835212293, 4861.246506791453, 4871.244957031666, 4872.4153101628035, 4917.680350777331, 4919.3604831371695, 4167.270727622593, 4399.934000990052, 4411.669124815716, 4428.313611390111, 4429.2027435062, 3598.4962105305804, 3610.548681414823, 3621.1852333225866, 3626.1478552539606, 3627.147620309278, 5130.79476820923, 5136.356365963005, 5137.255098010843, 5140.331756871583, 5146.614003949644, 4748.88127796794, 4941.6293777966075, 4981.011393164217, 4995.776879288682, 5006.098902197639, 4947.678400903929, 4976.576990955809, 4989.476105009067, 4990.176620857663, 4993.201087825931, 4930.112579735539, 4931.48219436954, 4941.258811178352, 4942.629302802232, 4944.307796908363, 4873.269009648439, 4989.0, 5016.147254966591, 5041.8487445376695, 5042.0, 4935.629827763004, 4937.6426577164175, 4945.876353091057, 4949.133901567283, 4956.677815941952], "value": 3715.310253384718, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.3741351836037, 681.1281559603706, 731.2395109086547, 746.2127455534412, 750.197288900876, 13364.465421383145, 14216.644583885382, 14235.92882035591, 14239.71520569588, 14242.359093840776, 13565.25391103489, 13613.591592252224, 13632.113912595674, 13646.454141834314, 13668.863311366884, 652.7584793626353, 686.7356067913864, 792.3819420851717, 812.0823469479479, 824.983500329993, 819.5246756880995, 821.6466919224731, 821.9630116644736, 822.0464261456711, 822.6956026270288, 857.9485230886166, 859.9269062129727, 861.4831101339178, 862.2024627219828, 862.2326129744501, 702.5573888450294, 726.2265687043282, 835.5237514616671, 862.9525376104311, 869.1221865915408, 633.2654121219409, 633.3856159525253, 633.6324931539696, 633.6958260035162, 634.4068296143075, 13232.86767132326, 13579.660508487268, 13652.522161724291, 13658.385372658255, 13661.316934153352, 11653.184277100607, 12013.339266340348, 12135.817962730565, 12599.0, 12749.936250318782, 12212.145149839514, 12238.326892020936, 12303.200291980993, 12504.687382815411, 12648.873511264861, 4208.579142085798, 4209.473815773028, 4245.660347172219, 4261.0, 4274.444322238121, 62934.37065629331, 64024.679876600785, 64084.35915640877, 64190.0, 65667.99999999952, 10149.492525373702, 10180.898191017995, 10314.948425257826, 10446.843297350546, 10537.209709271836, 17605.823941760675, 17664.205110770046, 17789.288428462718, 17832.732509012374, 17943.641127177645, 6556.901646475307, 6588.40704336612, 6629.86740265192, 6704.564203326768, 6731.831704207434, 3586.4978902953085, 3678.4482327651067, 3690.612485689018, 3696.8890933272046, 3768.8304026318883, 2648.3246772073, 2696.4472283182295, 2710.417260289047, 2714.280715610365, 2721.986390068037, 450.8264318237502, 454.1190091223017, 462.3596319098006, 464.55634868700986, 465.57167405986576, 571.6455797405551, 575.1602660116278, 576.1415490918585, 586.8620874094585, 594.9970250148722, 7458.701651933862, 7615.352695020985, 8110.270075693216, 8188.672453101928, 8374.078851326349, 559.6502186133666, 590.7814108779693, 594.2334388638608, 596.3562632316542, 610.2036841921336, 3578.946315805265, 3682.1899182179877, 3697.7041836653543, 3738.4953031340965, 3789.0906182515996, 66669.33330666632, 67671.32328676748, 67906.98139527912, 70726.292737073, 71019.0, 41029.179416411505, 43569.34645980313, 46410.0, 52007.47992520102, 56850.746417894, 47295.5270447298, 48530.27204591934, 49027.50972490301, 51591.226131608055, 51598.48401515937, 8226.78767328228, 8733.08302628215, 8745.781355466164, 8745.868811967699, 8966.237869781142, 34095.65904340925, 35012.64987350094, 35937.28125437529, 36263.0, 36681.44977825281, 43103.0, 43130.0, 43255.567444326414, 44008.559914400445, 44249.0, 11006.614768483065, 11160.218784684994, 11193.216474846682, 11212.55149793999, 11264.324140551593, 12088.879111208775, 12288.81566776517, 12457.439415226156, 12549.184303020274, 12849.935750321189, 11729.237599556001, 12275.877241227474, 12291.75416491683, 12371.69070773238, 12811.295378753885, 10486.895131048592, 11636.418179090842, 11638.88361116378, 11918.940405297919, 12249.69375765613, 10563.735906602396, 11118.555257789598, 11168.385738784445, 11464.369459679798, 11491.942540287246, 10131.898681013095, 10416.739581510523, 10427.322224055411, 10712.946435267773, 10728.946355268174, 9388.624455021723, 9564.426134431957, 10286.485675716334, 10303.0, 10374.481275936023], "value": 6300.104973552025, "unit": "score"}], "name": "dromaeo_css", "value": 6127.276376726461, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 117.0, 116.0, 115.0, 114.0, 116.0, 114.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 131.0, 170.0, 136.0, 133.0, 128.0, 127.0, 151.0, 128.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 163.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 108.0, 77.0, 77.0, 77.0, 77.0, 91.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 108.0, 86.0, 85.0, 85.0, 99.0, 86.0, 86.0, 109.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 151.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 61.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 85.0, 88.0, 86.0, 97.0, 85.0, 96.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 141.0, 134.0, 141.0, 132.0, 133.0, 133.0, 176.0, 145.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 176.0, 176.0, 177.0, 180.0, 177.0, 177.0, 179.0, 181.0, 176.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 74.0, 70.0, 73.0, 68.0, 70.0, 71.0, 72.0, 68.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1554.5000000000002, "alertThreshold": 2.0}]} 07:17:42 INFO - Return code: 0 07:17:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:17:42 INFO - # TBPL SUCCESS # 07:17:42 INFO - Running post-action listener: _resource_record_post_action 07:17:42 INFO - [mozharness: 2017-01-03 15:17:42.435985Z] Finished run-tests step (success) 07:17:42 INFO - Running post-run listener: _resource_record_post_run 07:17:42 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394022912; Read time: 8; Write time: 251648 07:17:42 INFO - TinderboxPrint: CPU usage
13.1% 07:17:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:17:42 INFO - TinderboxPrint: I/O write bytes / time
394,022,912 / 251,648 07:17:42 INFO - TinderboxPrint: CPU idle
8,331.8 (86.9%) 07:17:42 INFO - TinderboxPrint: CPU user
1,210.4 (12.6%) 07:17:42 INFO - TinderboxPrint: Swap in / out
0 / 0 07:17:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110325760; Read time: 0; Write time: 58884 07:17:42 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 282525696; Read time: 0; Write time: 192736 07:17:43 INFO - Running post-run listener: _upload_blobber_files 07:17:43 INFO - Blob upload gear active. 07:17:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:17:43 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 07:17:43 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:17:43 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:17:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:17:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:17:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:17:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:44 INFO - (blobuploader) - INFO - Done attempting. 07:17:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:17:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:17:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:45 INFO - (blobuploader) - INFO - Done attempting. 07:17:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:17:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:48 INFO - (blobuploader) - INFO - Done attempting. 07:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:49 INFO - (blobuploader) - INFO - Done attempting. 07:17:49 INFO - (blobuploader) - INFO - Iteration through files over. 07:17:49 INFO - Return code: 0 07:17:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:17:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:17:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f057a73fd5843bbd3a203f8eef72b6244f9081fe70d607c6ffc234d89da224e6c594067108fb96263eb8bb34d8d41381d09f2b7af5f2ed8f3e7dfbc0d5b8700a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6555465edb6bc16c653770a63b2e46482fe13f46d6aecb8302f24d983fa3fc2b71b6ea66c8e3a8567bd13233fb41fcd3865c1f4204eb29d01576973bc8a1d2a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4424c1aef832407ef9e504aa74fe5f5451468158aeb39624fded6ad426367d8d2751ebd4faf24f16c4bfc9f3edde4d96653cf5bb89960fbf2ecffab66868e6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/401c595dc5f837bd9fe33815acc7cdf28725c6de7d5cc6c7f8a61dcecca0d426a61ca2bf33ae9c0aa016768da7e03d1c66fde06febad09ef16706042c56ff681"} 07:17:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:17:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:17:49 INFO - Contents: 07:17:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f057a73fd5843bbd3a203f8eef72b6244f9081fe70d607c6ffc234d89da224e6c594067108fb96263eb8bb34d8d41381d09f2b7af5f2ed8f3e7dfbc0d5b8700a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6555465edb6bc16c653770a63b2e46482fe13f46d6aecb8302f24d983fa3fc2b71b6ea66c8e3a8567bd13233fb41fcd3865c1f4204eb29d01576973bc8a1d2a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4424c1aef832407ef9e504aa74fe5f5451468158aeb39624fded6ad426367d8d2751ebd4faf24f16c4bfc9f3edde4d96653cf5bb89960fbf2ecffab66868e6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/401c595dc5f837bd9fe33815acc7cdf28725c6de7d5cc6c7f8a61dcecca0d426a61ca2bf33ae9c0aa016768da7e03d1c66fde06febad09ef16706042c56ff681"} 07:17:49 INFO - Running post-run listener: copy_logs_to_upload_dir 07:17:49 INFO - Copying logs to upload dir... 07:17:49 INFO - mkdir: /builds/slave/test/build/upload/logs 07:17:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.812415 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-03 07:17:47.876786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 07:17:47.880531) ========= 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=41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f057a73fd5843bbd3a203f8eef72b6244f9081fe70d607c6ffc234d89da224e6c594067108fb96263eb8bb34d8d41381d09f2b7af5f2ed8f3e7dfbc0d5b8700a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6555465edb6bc16c653770a63b2e46482fe13f46d6aecb8302f24d983fa3fc2b71b6ea66c8e3a8567bd13233fb41fcd3865c1f4204eb29d01576973bc8a1d2a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4424c1aef832407ef9e504aa74fe5f5451468158aeb39624fded6ad426367d8d2751ebd4faf24f16c4bfc9f3edde4d96653cf5bb89960fbf2ecffab66868e6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/401c595dc5f837bd9fe33815acc7cdf28725c6de7d5cc6c7f8a61dcecca0d426a61ca2bf33ae9c0aa016768da7e03d1c66fde06febad09ef16706042c56ff681"} build_url:https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/ZA_lOUtNQt6_yKiVL_8Maw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f057a73fd5843bbd3a203f8eef72b6244f9081fe70d607c6ffc234d89da224e6c594067108fb96263eb8bb34d8d41381d09f2b7af5f2ed8f3e7dfbc0d5b8700a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6555465edb6bc16c653770a63b2e46482fe13f46d6aecb8302f24d983fa3fc2b71b6ea66c8e3a8567bd13233fb41fcd3865c1f4204eb29d01576973bc8a1d2a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4424c1aef832407ef9e504aa74fe5f5451468158aeb39624fded6ad426367d8d2751ebd4faf24f16c4bfc9f3edde4d96653cf5bb89960fbf2ecffab66868e6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/401c595dc5f837bd9fe33815acc7cdf28725c6de7d5cc6c7f8a61dcecca0d426a61ca2bf33ae9c0aa016768da7e03d1c66fde06febad09ef16706042c56ff681"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 07:17:47.906447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:17:47.906775) ========= 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=41bf3e9aed84707956354da8000001c5-1483455204.481081-1936985287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:17:47.992107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 07:17:47.992479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 07:17:47.992904) ========= ========= Total master_lag: 0.20 =========