builder: pine_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1490320790.96 results: success (0) revision: 84ba19887b668b16c7d2e182f6d61524a2904b9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:50.964200) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:50.964956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:50.965446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:50.982788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:50.983435) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 18:59:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.6M=0s 2017-03-23 18:59:52 (95.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:51.146551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:51.146953) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020116 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:51.196229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:51.196600) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 84ba19887b668b16c7d2e182f6d61524a2904b9e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/pine --rev 84ba19887b668b16c7d2e182f6d61524a2904b9e --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=a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 18:59:52,269 truncating revision to first 12 chars 2017-03-23 18:59:52,269 Setting DEBUG logging. 2017-03-23 18:59:52,269 attempt 1/10 2017-03-23 18:59:52,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/84ba19887b66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 18:59:52,780 unpacking tar archive at: pine-84ba19887b66/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:51.999854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:52.000177) ========= script_repo_revision: 84ba19887b668b16c7d2e182f6d61524a2904b9e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:52.000560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:52.000819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 18:59:52.010382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-03-23 18:59:52.010682) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] 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=a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:53 INFO - MultiFileLogger online at 20170323 18:59:53 in /builds/slave/test 18:59:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 18:59:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:53 INFO - {'append_to_log': False, 18:59:53 INFO - 'base_work_dir': '/builds/slave/test', 18:59:53 INFO - 'blob_upload_branch': 'Pine', 18:59:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:53 INFO - 'branch': 'Pine', 18:59:53 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:53 INFO - 'config_files': ('talos/linux_config.py',), 18:59:53 INFO - 'default_actions': ('clobber', 18:59:53 INFO - 'read-buildbot-config', 18:59:53 INFO - 'download-and-extract', 18:59:53 INFO - 'populate-webroot', 18:59:53 INFO - 'create-virtualenv', 18:59:53 INFO - 'install', 18:59:53 INFO - 'run-tests'), 18:59:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:53 INFO - 'download_minidump_stackwalk': True, 18:59:53 INFO - 'download_symbols': 'ondemand', 18:59:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:53 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:53 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:53 INFO - 'gecko_profile': False, 18:59:53 INFO - 'gecko_profile_interval': 0, 18:59:53 INFO - 'installer_path': 'installer.exe', 18:59:53 INFO - 'log_level': 'info', 18:59:53 INFO - 'log_name': 'talos', 18:59:53 INFO - 'log_to_console': True, 18:59:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:53 INFO - 'opt_config_files': (), 18:59:53 INFO - 'pip_index': False, 18:59:53 INFO - 'suite': 'dromaeojs', 18:59:53 INFO - 'system_bits': '32', 18:59:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:53 INFO - 'title': 'talos-linux64-ix-064', 18:59:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:53 INFO - 'use_talos_json': True, 18:59:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:53 INFO - 'work_dir': 'build'} 18:59:53 INFO - [mozharness: 2017-03-24 01:59:53.184597Z] Running clobber step. 18:59:53 INFO - Running pre-action listener: _resource_record_pre_action 18:59:53 INFO - Running main action method: clobber 18:59:53 INFO - rmtree: /builds/slave/test/build 18:59:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:54 INFO - Running post-action listener: _resource_record_post_action 18:59:54 INFO - [mozharness: 2017-03-24 01:59:54.122857Z] Finished clobber step (success) 18:59:54 INFO - [mozharness: 2017-03-24 01:59:54.122958Z] Running read-buildbot-config step. 18:59:54 INFO - Running pre-action listener: _resource_record_pre_action 18:59:54 INFO - Running main action method: read_buildbot_config 18:59:54 INFO - Using buildbot properties: 18:59:54 INFO - { 18:59:54 INFO - "project": "", 18:59:54 INFO - "product": "firefox", 18:59:54 INFO - "who": "dmosedale@mozilla.com", 18:59:54 INFO - "installer_path": "public/build/target.tar.bz2", 18:59:54 INFO - "builddir": "pine_ubuntu64_hw_test-dromaeojs", 18:59:54 INFO - "repository": "https://hg.mozilla.org/projects/pine/", 18:59:54 INFO - "buildername": "Ubuntu HW 12.04 x64 pine talos dromaeojs", 18:59:54 INFO - "stage_platform": "linux64", 18:59:54 INFO - "basedir": "/builds/slave/test", 18:59:54 INFO - "buildnumber": 0, 18:59:54 INFO - "platform": "ubuntu64_hw", 18:59:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:59:54 INFO - "slavebuilddir": "test", 18:59:54 INFO - "taskId": "BYl_lXkcSmKNmLcu2zFZvA", 18:59:54 INFO - "branch": "pine", 18:59:54 INFO - "script_repo_revision": "default", 18:59:54 INFO - "revision": "84ba19887b668b16c7d2e182f6d61524a2904b9e", 18:59:54 INFO - "slavename": "talos-linux64-ix-064", 18:59:54 INFO - "repo_path": "projects/pine" 18:59:54 INFO - } 18:59:54 INFO - Finding installer, test and symbols from parent task. 18:59:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BYl_lXkcSmKNmLcu2zFZvA'}, attempt #1 18:59:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BYl_lXkcSmKNmLcu2zFZvA'}, attempt #1 18:59:55 INFO - Task dependencies: BB5OsR0cSquSGZobh5SR5g 18:59:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g'}, attempt #1 18:59:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 18:59:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/test_packages.json 18:59:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip 18:59:55 INFO - Running post-action listener: _resource_record_post_action 18:59:55 INFO - [mozharness: 2017-03-24 01:59:55.607253Z] Finished read-buildbot-config step (success) 18:59:55 INFO - [mozharness: 2017-03-24 01:59:55.607470Z] Running download-and-extract step. 18:59:55 INFO - Running pre-action listener: _resource_record_pre_action 18:59:55 INFO - Running main action method: download_and_extract 18:59:55 INFO - mkdir: /builds/slave/test/build/tests 18:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:55 INFO - trying https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.test_packages.json 18:59:55 INFO - Downloading https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:59:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:59:56 INFO - Downloaded 986 bytes. 18:59:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:59:56 INFO - Using the following test package requirements: 18:59:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:59:56 INFO - u'common': [u'target.common.tests.zip'], 18:59:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:59:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:59:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:59:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:59:56 INFO - u'mozbase': [u'target.common.tests.zip'], 18:59:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:59:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:59:56 INFO - u'web-platform': [u'target.common.tests.zip', 18:59:56 INFO - u'target.web-platform.tests.zip'], 18:59:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:59:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:59:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip 18:59:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:59:56 INFO - Fetch https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip into memory 18:59:58 INFO - Expected file size: 58125537 18:59:58 INFO - Obtained file size: 58125537 19:00:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:00:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip 19:00:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:00:08 INFO - Fetch https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.common.tests.zip into memory 19:00:09 INFO - Expected file size: 58125537 19:00:09 INFO - Obtained file size: 58125537 19:00:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.talos.tests.zip 19:00:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:00:20 INFO - Fetch https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.talos.tests.zip into memory 19:00:22 INFO - Expected file size: 14404171 19:00:22 INFO - Obtained file size: 14404171 19:00:22 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')]} 19:00:22 INFO - trying https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 19:00:22 INFO - Downloading https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:00:24 INFO - Downloaded 62535148 bytes. 19:00:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 19:00:24 INFO - mkdir: /builds/slave/test/properties 19:00:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:24 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:24 INFO - Contents: 19:00:24 INFO - build_url:https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 19:00:24 INFO - Running post-action listener: _resource_record_post_action 19:00:24 INFO - Running post-action listener: set_extra_try_arguments 19:00:24 INFO - [mozharness: 2017-03-24 02:00:24.514884Z] Finished download-and-extract step (success) 19:00:24 INFO - [mozharness: 2017-03-24 02:00:24.514981Z] Running populate-webroot step. 19:00:24 INFO - Running pre-action listener: _resource_record_pre_action 19:00:24 INFO - Running main action method: populate_webroot 19:00:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:24 INFO - '--tppagecycles', 19:00:24 INFO - '7'], 19:00:24 INFO - 'tests': ['tsvgm']}}, 19:00:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:00:24 INFO - 'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:00:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:00:24 INFO - 'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['damp', 'tps']}, 19:00:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:00:24 INFO - 'tests': ['damp', 'tps']}, 19:00:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['dromaeo_dom']}, 19:00:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['basic_compositor_video']}, 19:00:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:00:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['a11yr', 19:00:24 INFO - 'ts_paint', 19:00:24 INFO - 'tpaint', 19:00:24 INFO - 'sessionrestore', 19:00:24 INFO - 'sessionrestore_no_auto_restore', 19:00:24 INFO - 'tabpaint']}, 19:00:24 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:24 INFO - 'ts_paint', 19:00:24 INFO - 'tpaint', 19:00:24 INFO - 'sessionrestore', 19:00:24 INFO - 'sessionrestore_no_auto_restore', 19:00:24 INFO - 'tabpaint']}, 19:00:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:24 INFO - 'ts_paint', 19:00:24 INFO - 'tpaint', 19:00:24 INFO - 'sessionrestore', 19:00:24 INFO - 'sessionrestore_no_auto_restore', 19:00:24 INFO - 'tabpaint']}, 19:00:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:24 INFO - 'ts_paint', 19:00:24 INFO - 'tpaint', 19:00:24 INFO - 'sessionrestore', 19:00:24 INFO - 'sessionrestore_no_auto_restore', 19:00:24 INFO - 'tabpaint']}, 19:00:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['a11yr', 19:00:24 INFO - 'ts_paint', 19:00:24 INFO - 'tpaint', 19:00:24 INFO - 'sessionrestore', 19:00:24 INFO - 'sessionrestore_no_auto_restore', 19:00:24 INFO - 'tabpaint']}, 19:00:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['a11yr', 19:00:24 INFO - 'ts_paint', 19:00:24 INFO - 'tpaint', 19:00:24 INFO - 'sessionrestore', 19:00:24 INFO - 'sessionrestore_no_auto_restore', 19:00:24 INFO - 'tabpaint']}, 19:00:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['tsvgx', 19:00:24 INFO - 'tsvgr_opacity', 19:00:24 INFO - 'tart', 19:00:24 INFO - 'tscrollx', 19:00:24 INFO - 'cart', 19:00:24 INFO - 'tsvg_static']}, 19:00:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:24 INFO - 'tsvgr_opacity', 19:00:24 INFO - 'tart', 19:00:24 INFO - 'tscrollx', 19:00:24 INFO - 'cart', 19:00:24 INFO - 'tsvg_static']}, 19:00:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:00:24 INFO - 'talos_options': ['--disable-e10s'], 19:00:24 INFO - 'tests': ['tp5o']}, 19:00:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:00:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:00:24 INFO - 'talos_options': ['--disable-e10s', 19:00:24 INFO - '--xperf_path', 19:00:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:24 INFO - 'tests': ['tp5n']}, 19:00:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:00:24 INFO - 'talos_options': ['--xperf_path', 19:00:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:24 INFO - 'tests': ['tp5n']}}, 19:00:24 INFO - 'talos.zip': {'path': '', 19:00:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:24 INFO - Running post-action listener: _resource_record_post_action 19:00:24 INFO - [mozharness: 2017-03-24 02:00:24.528198Z] Finished populate-webroot step (success) 19:00:24 INFO - [mozharness: 2017-03-24 02:00:24.528290Z] Running create-virtualenv step. 19:00:24 INFO - Running pre-action listener: _resource_record_pre_action 19:00:24 INFO - Running main action method: create_virtualenv 19:00:24 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:24 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 19:00:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:24 INFO - Using real prefix '/usr' 19:00:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:25 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:27 INFO - Installing pip.................done. 19:00:27 INFO - Return code: 0 19:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:00:27 INFO - Reading from file tmpfile_stdout 19:00:27 INFO - Output received: 19:00:27 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) 19:00:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:27 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')]} 19:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:27 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')]} 19:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:27 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:27 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 19:00:27 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 19:00:27 INFO - Using env: {'DISPLAY': ':0', 19:00:27 INFO - 'HOME': '/home/cltbld', 19:00:27 INFO - 'LANG': 'en_US.UTF-8', 19:00:27 INFO - 'LANGUAGE': 'en_US:en', 19:00:27 INFO - 'LOGNAME': 'cltbld', 19:00:27 INFO - 'MAIL': '/var/mail/cltbld', 19:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:27 INFO - 'MOZ_NO_REMOTE': '1', 19:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:27 INFO - 'NO_EM_RESTART': '1', 19:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:27 INFO - 'PWD': '/builds/slave/test', 19:00:27 INFO - 'SHELL': '/bin/bash', 19:00:27 INFO - 'SHLVL': '1', 19:00:27 INFO - 'TERM': 'linux', 19:00:27 INFO - 'TMOUT': '86400', 19:00:27 INFO - 'USER': 'cltbld', 19:00:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:27 INFO - '_': '/tools/buildbot/bin/python'} 19:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:27 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 19:00:27 INFO - Cleaning up... 19:00:27 INFO - Return code: 0 19:00:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00:27 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')]} 19:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:27 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')]} 19:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:27 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:27 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 19:00:27 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 19:00:27 INFO - Using env: {'DISPLAY': ':0', 19:00:27 INFO - 'HOME': '/home/cltbld', 19:00:27 INFO - 'LANG': 'en_US.UTF-8', 19:00:27 INFO - 'LANGUAGE': 'en_US:en', 19:00:27 INFO - 'LOGNAME': 'cltbld', 19:00:27 INFO - 'MAIL': '/var/mail/cltbld', 19:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:27 INFO - 'MOZ_NO_REMOTE': '1', 19:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:27 INFO - 'NO_EM_RESTART': '1', 19:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:27 INFO - 'PWD': '/builds/slave/test', 19:00:27 INFO - 'SHELL': '/bin/bash', 19:00:27 INFO - 'SHLVL': '1', 19:00:27 INFO - 'TERM': 'linux', 19:00:27 INFO - 'TMOUT': '86400', 19:00:27 INFO - 'USER': 'cltbld', 19:00:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:27 INFO - '_': '/tools/buildbot/bin/python'} 19:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:27 INFO - Downloading/unpacking psutil>=3.1.1 19:00:27 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 19:00:27 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 19:00:27 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 19:00:27 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 19:00:27 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 19:00:27 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 19:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:29 INFO - Installing collected packages: psutil 19:00:29 INFO - Running setup.py install for psutil 19:00:29 INFO - building 'psutil._psutil_linux' extension 19:00:29 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 19:00:30 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 19:00:30 INFO - building 'psutil._psutil_posix' extension 19:00:30 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 19:00:30 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 19:00:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:30 INFO - Successfully installed psutil 19:00:30 INFO - Cleaning up... 19:00:30 INFO - Return code: 0 19:00:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00:30 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')]} 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:30 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')]} 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:30 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:30 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 19:00:30 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 19:00:30 INFO - Using env: {'DISPLAY': ':0', 19:00:30 INFO - 'HOME': '/home/cltbld', 19:00:30 INFO - 'LANG': 'en_US.UTF-8', 19:00:30 INFO - 'LANGUAGE': 'en_US:en', 19:00:30 INFO - 'LOGNAME': 'cltbld', 19:00:30 INFO - 'MAIL': '/var/mail/cltbld', 19:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:30 INFO - 'MOZ_NO_REMOTE': '1', 19:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:30 INFO - 'NO_EM_RESTART': '1', 19:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:30 INFO - 'PWD': '/builds/slave/test', 19:00:30 INFO - 'SHELL': '/bin/bash', 19:00:30 INFO - 'SHLVL': '1', 19:00:30 INFO - 'TERM': 'linux', 19:00:30 INFO - 'TMOUT': '86400', 19:00:30 INFO - 'USER': 'cltbld', 19:00:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:30 INFO - '_': '/tools/buildbot/bin/python'} 19:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:30 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 19:00:30 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 19:00:30 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 19:00:30 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 19:00:30 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 19:00:30 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 19:00:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:32 INFO - Installing collected packages: mozsystemmonitor 19:00:32 INFO - Running setup.py install for mozsystemmonitor 19:00:32 INFO - Successfully installed mozsystemmonitor 19:00:32 INFO - Cleaning up... 19:00:32 INFO - Return code: 0 19:00:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00:32 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')]} 19:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:32 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')]} 19:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:32 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:32 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 19:00:32 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 19:00:32 INFO - Using env: {'DISPLAY': ':0', 19:00:32 INFO - 'HOME': '/home/cltbld', 19:00:32 INFO - 'LANG': 'en_US.UTF-8', 19:00:32 INFO - 'LANGUAGE': 'en_US:en', 19:00:32 INFO - 'LOGNAME': 'cltbld', 19:00:32 INFO - 'MAIL': '/var/mail/cltbld', 19:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:32 INFO - 'MOZ_NO_REMOTE': '1', 19:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:32 INFO - 'NO_EM_RESTART': '1', 19:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:32 INFO - 'PWD': '/builds/slave/test', 19:00:32 INFO - 'SHELL': '/bin/bash', 19:00:32 INFO - 'SHLVL': '1', 19:00:32 INFO - 'TERM': 'linux', 19:00:32 INFO - 'TMOUT': '86400', 19:00:32 INFO - 'USER': 'cltbld', 19:00:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:32 INFO - '_': '/tools/buildbot/bin/python'} 19:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:33 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:33 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 19:00:33 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 19:00:33 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 19:00:33 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 19:00:33 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 19:00:33 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 19:00:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00:35 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 19:00:35 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 19:00:35 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 19:00:35 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 19:00:35 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 19:00:35 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 19:00:35 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:35 INFO - warning: no files found matching '*.txt' 19:00:35 INFO - no previously-included directories found matching 'build' 19:00:35 INFO - no previously-included directories found matching 'dist' 19:00:35 INFO - no previously-included directories found matching '.git*' 19:00:35 INFO - Installing collected packages: jsonschema, functools32 19:00:35 INFO - Running setup.py install for functools32 19:00:35 INFO - warning: no files found matching '*.txt' 19:00:35 INFO - no previously-included directories found matching 'build' 19:00:35 INFO - no previously-included directories found matching 'dist' 19:00:35 INFO - no previously-included directories found matching '.git*' 19:00:35 INFO - Successfully installed jsonschema functools32 19:00:35 INFO - Cleaning up... 19:00:35 INFO - Return code: 0 19:00:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:35 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:35 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 19:00:35 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 19:00:35 INFO - Using env: {'DISPLAY': ':0', 19:00:35 INFO - 'HOME': '/home/cltbld', 19:00:35 INFO - 'LANG': 'en_US.UTF-8', 19:00:35 INFO - 'LANGUAGE': 'en_US:en', 19:00:35 INFO - 'LOGNAME': 'cltbld', 19:00:35 INFO - 'MAIL': '/var/mail/cltbld', 19:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:35 INFO - 'MOZ_NO_REMOTE': '1', 19:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:35 INFO - 'NO_EM_RESTART': '1', 19:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:35 INFO - 'PWD': '/builds/slave/test', 19:00:35 INFO - 'SHELL': '/bin/bash', 19:00:35 INFO - 'SHLVL': '1', 19:00:35 INFO - 'TERM': 'linux', 19:00:35 INFO - 'TMOUT': '86400', 19:00:35 INFO - 'USER': 'cltbld', 19:00:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:35 INFO - '_': '/tools/buildbot/bin/python'} 19:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:00:35 INFO - Cleaning up... 19:00:35 INFO - Return code: 0 19:00:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:35 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:35 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 19:00:35 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 19:00:35 INFO - Using env: {'DISPLAY': ':0', 19:00:35 INFO - 'HOME': '/home/cltbld', 19:00:35 INFO - 'LANG': 'en_US.UTF-8', 19:00:35 INFO - 'LANGUAGE': 'en_US:en', 19:00:35 INFO - 'LOGNAME': 'cltbld', 19:00:35 INFO - 'MAIL': '/var/mail/cltbld', 19:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:35 INFO - 'MOZ_NO_REMOTE': '1', 19:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:35 INFO - 'NO_EM_RESTART': '1', 19:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:35 INFO - 'PWD': '/builds/slave/test', 19:00:35 INFO - 'SHELL': '/bin/bash', 19:00:35 INFO - 'SHLVL': '1', 19:00:35 INFO - 'TERM': 'linux', 19:00:35 INFO - 'TMOUT': '86400', 19:00:35 INFO - 'USER': 'cltbld', 19:00:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:35 INFO - '_': '/tools/buildbot/bin/python'} 19:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:36 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:38 INFO - Downloading docopt-0.6.1.tar.gz 19:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:38 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:38 INFO - Running setup.py install for blobuploader 19:00:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:38 INFO - Running setup.py install for requests 19:00:39 INFO - Running setup.py install for docopt 19:00:39 INFO - Successfully installed blobuploader requests docopt 19:00:39 INFO - Cleaning up... 19:00:39 INFO - Return code: 0 19:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:39 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:39 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 19:00:39 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 19:00:39 INFO - Using env: {'DISPLAY': ':0', 19:00:39 INFO - 'HOME': '/home/cltbld', 19:00:39 INFO - 'LANG': 'en_US.UTF-8', 19:00:39 INFO - 'LANGUAGE': 'en_US:en', 19:00:39 INFO - 'LOGNAME': 'cltbld', 19:00:39 INFO - 'MAIL': '/var/mail/cltbld', 19:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:39 INFO - 'MOZ_NO_REMOTE': '1', 19:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:39 INFO - 'NO_EM_RESTART': '1', 19:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:39 INFO - 'PWD': '/builds/slave/test', 19:00:39 INFO - 'SHELL': '/bin/bash', 19:00:39 INFO - 'SHLVL': '1', 19:00:39 INFO - 'TERM': 'linux', 19:00:39 INFO - 'TMOUT': '86400', 19:00:39 INFO - 'USER': 'cltbld', 19:00:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:39 INFO - '_': '/tools/buildbot/bin/python'} 19:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:39 INFO - Running setup.py (path:/tmp/pip-jnRBdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:39 INFO - Running setup.py (path:/tmp/pip-vBAjFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:39 INFO - Running setup.py (path:/tmp/pip-RdPfFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:39 INFO - Running setup.py (path:/tmp/pip-emK0Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:39 INFO - Running setup.py (path:/tmp/pip-7adBZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:40 INFO - Running setup.py (path:/tmp/pip-neeG2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:40 INFO - Running setup.py (path:/tmp/pip-zhAJwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:40 INFO - Running setup.py (path:/tmp/pip-upRB82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:40 INFO - Running setup.py (path:/tmp/pip-10HS25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:40 INFO - Running setup.py (path:/tmp/pip-PU07LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:40 INFO - Running setup.py (path:/tmp/pip-1Y9xyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:40 INFO - Running setup.py (path:/tmp/pip-8WHJf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:40 INFO - Running setup.py (path:/tmp/pip-AAsp0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:40 INFO - Running setup.py (path:/tmp/pip-J_0L7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:40 INFO - Running setup.py (path:/tmp/pip-H5jGMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:40 INFO - Running setup.py (path:/tmp/pip-EcKHYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:40 INFO - Running setup.py (path:/tmp/pip-7zoGAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:40 INFO - Running setup.py install for manifestparser 19:00:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozcrash 19:00:41 INFO - Running setup.py install for mozdebug 19:00:41 INFO - Running setup.py install for mozdevice 19:00:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozfile 19:00:41 INFO - Running setup.py install for mozhttpd 19:00:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozinfo 19:00:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozInstall 19:00:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for mozleak 19:00:41 INFO - Running setup.py install for mozlog 19:00:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:41 INFO - Running setup.py install for moznetwork 19:00:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Running setup.py install for mozprocess 19:00:42 INFO - Running setup.py install for mozprofile 19:00:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Running setup.py install for mozrunner 19:00:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Running setup.py install for mozscreenshot 19:00:42 INFO - Running setup.py install for moztest 19:00:42 INFO - Running setup.py install for mozversion 19:00:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:42 INFO - Cleaning up... 19:00:42 INFO - Return code: 0 19:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:42 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:42 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 19:00:42 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 19:00:42 INFO - Using env: {'DISPLAY': ':0', 19:00:42 INFO - 'HOME': '/home/cltbld', 19:00:42 INFO - 'LANG': 'en_US.UTF-8', 19:00:42 INFO - 'LANGUAGE': 'en_US:en', 19:00:42 INFO - 'LOGNAME': 'cltbld', 19:00:42 INFO - 'MAIL': '/var/mail/cltbld', 19:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:42 INFO - 'MOZ_NO_REMOTE': '1', 19:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:42 INFO - 'NO_EM_RESTART': '1', 19:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:42 INFO - 'PWD': '/builds/slave/test', 19:00:42 INFO - 'SHELL': '/bin/bash', 19:00:42 INFO - 'SHLVL': '1', 19:00:42 INFO - 'TERM': 'linux', 19:00:42 INFO - 'TMOUT': '86400', 19:00:42 INFO - 'USER': 'cltbld', 19:00:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:42 INFO - '_': '/tools/buildbot/bin/python'} 19:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:42 INFO - Running setup.py (path:/tmp/pip-dwKr4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:43 INFO - Running setup.py (path:/tmp/pip-43CIzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:43 INFO - Running setup.py (path:/tmp/pip-Tk3yU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:43 INFO - Running setup.py (path:/tmp/pip-WzeXi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:43 INFO - Running setup.py (path:/tmp/pip-gYaJWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:43 INFO - Running setup.py (path:/tmp/pip-bnhj0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:43 INFO - Running setup.py (path:/tmp/pip-Evgsav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:43 INFO - Running setup.py (path:/tmp/pip-iFoLVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:43 INFO - Running setup.py (path:/tmp/pip-j0SZ8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:43 INFO - Running setup.py (path:/tmp/pip-LUniqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:43 INFO - Running setup.py (path:/tmp/pip-Gr_giW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:43 INFO - Running setup.py (path:/tmp/pip-2G3v4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:43 INFO - Running setup.py (path:/tmp/pip-OlTQzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:43 INFO - Running setup.py (path:/tmp/pip-CK4rUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:43 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)) 19:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:43 INFO - Running setup.py (path:/tmp/pip-mCRuJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:44 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)) 19:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:44 INFO - Running setup.py (path:/tmp/pip-d2rJy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:44 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)) 19:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:44 INFO - Running setup.py (path:/tmp/pip-p7uoAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 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)) 19:00:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:44 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 19:00:44 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 19:00:44 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 19:00:44 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 19:00:44 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 19:00:44 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 19:00:46 INFO - Downloading blessings-1.6.tar.gz 19:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:46 INFO - Installing collected packages: blessings 19:00:46 INFO - Running setup.py install for blessings 19:00:46 INFO - Successfully installed blessings 19:00:46 INFO - Cleaning up... 19:00:46 INFO - Return code: 0 19:00:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:46 INFO - Reading from file tmpfile_stdout 19:00:46 INFO - Current package versions: 19:00:46 INFO - argparse == 1.2.1 19:00:46 INFO - blessings == 1.6 19:00:46 INFO - blobuploader == 1.2.4 19:00:46 INFO - docopt == 0.6.1 19:00:46 INFO - functools32 == 3.2.3-2 19:00:46 INFO - jsonschema == 2.5.1 19:00:46 INFO - manifestparser == 1.1 19:00:46 INFO - mozInstall == 1.12 19:00:46 INFO - mozcrash == 1.0 19:00:46 INFO - mozdebug == 0.1 19:00:46 INFO - mozdevice == 0.49 19:00:46 INFO - mozfile == 1.2 19:00:46 INFO - mozhttpd == 0.7 19:00:46 INFO - mozinfo == 0.9 19:00:46 INFO - mozleak == 0.1 19:00:46 INFO - mozlog == 3.4 19:00:46 INFO - moznetwork == 0.27 19:00:46 INFO - mozprocess == 0.25 19:00:46 INFO - mozprofile == 0.28 19:00:46 INFO - mozrunner == 6.13 19:00:46 INFO - mozscreenshot == 0.1 19:00:46 INFO - mozsystemmonitor == 0.3 19:00:46 INFO - moztest == 0.8 19:00:46 INFO - mozversion == 1.4 19:00:46 INFO - psutil == 3.1.1 19:00:46 INFO - requests == 1.2.3 19:00:46 INFO - wsgiref == 0.1.2 19:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:46 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 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:46 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 19:00:46 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 19:00:46 INFO - Using env: {'DISPLAY': ':0', 19:00:46 INFO - 'HOME': '/home/cltbld', 19:00:46 INFO - 'LANG': 'en_US.UTF-8', 19:00:46 INFO - 'LANGUAGE': 'en_US:en', 19:00:46 INFO - 'LOGNAME': 'cltbld', 19:00:46 INFO - 'MAIL': '/var/mail/cltbld', 19:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:46 INFO - 'MOZ_NO_REMOTE': '1', 19:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:46 INFO - 'NO_EM_RESTART': '1', 19:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:46 INFO - 'PWD': '/builds/slave/test', 19:00:46 INFO - 'SHELL': '/bin/bash', 19:00:46 INFO - 'SHLVL': '1', 19:00:46 INFO - 'TERM': 'linux', 19:00:46 INFO - 'TMOUT': '86400', 19:00:46 INFO - 'USER': 'cltbld', 19:00:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:46 INFO - '_': '/tools/buildbot/bin/python'} 19:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 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)) 19:00:47 INFO - Cleaning up... 19:00:47 INFO - Return code: 0 19:00:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', '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 19:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:47 INFO - Using env: {'DISPLAY': ':0', 19:00:47 INFO - 'HOME': '/home/cltbld', 19:00:47 INFO - 'LANG': 'en_US.UTF-8', 19:00:47 INFO - 'LANGUAGE': 'en_US:en', 19:00:47 INFO - 'LOGNAME': 'cltbld', 19:00:47 INFO - 'MAIL': '/var/mail/cltbld', 19:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:47 INFO - 'MOZ_NO_REMOTE': '1', 19:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:47 INFO - 'NO_EM_RESTART': '1', 19:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:47 INFO - 'PWD': '/builds/slave/test', 19:00:47 INFO - 'SHELL': '/bin/bash', 19:00:47 INFO - 'SHLVL': '1', 19:00:47 INFO - 'TERM': 'linux', 19:00:47 INFO - 'TMOUT': '86400', 19:00:47 INFO - 'USER': 'cltbld', 19:00:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:47 INFO - '_': '/tools/buildbot/bin/python'} 19:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:47 INFO - Cleaning up... 19:00:47 INFO - Return code: 0 19:00:47 INFO - Running post-action listener: _resource_record_post_action 19:00:47 INFO - Running post-action listener: _start_resource_monitoring 19:00:47 INFO - Starting resource monitoring. 19:00:47 INFO - [mozharness: 2017-03-24 02:00:47.282595Z] Finished create-virtualenv step (success) 19:00:47 INFO - [mozharness: 2017-03-24 02:00:47.283110Z] Running install step. 19:00:47 INFO - Running pre-action listener: _resource_record_pre_action 19:00:47 INFO - Running main action method: install 19:00:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:47 INFO - Reading from file tmpfile_stdout 19:00:47 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:47 INFO - Reading from file tmpfile_stdout 19:00:47 INFO - Output received: 19:00:47 INFO - Usage: mozinstall [options] installer 19:00:47 INFO - Options: 19:00:47 INFO - -h, --help show this help message and exit 19:00:47 INFO - -d DEST, --destination=DEST 19:00:47 INFO - Directory to install application into. [default: 19:00:47 INFO - "/builds/slave/test"] 19:00:47 INFO - --app=APP Application being installed. [default: firefox] 19:00:47 INFO - mkdir: /builds/slave/test/build/application 19:00:47 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'] 19:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:01:03 INFO - Reading from file tmpfile_stdout 19:01:03 INFO - Output received: 19:01:03 INFO - /builds/slave/test/build/application/firefox/firefox 19:01:03 INFO - Running post-action listener: _resource_record_post_action 19:01:03 INFO - [mozharness: 2017-03-24 02:01:03.271551Z] Finished install step (success) 19:01:03 INFO - [mozharness: 2017-03-24 02:01:03.271892Z] Running run-tests step. 19:01:03 INFO - Running pre-action listener: _resource_record_pre_action 19:01:03 INFO - Running main action method: run_tests 19:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:03 INFO - Python 2.7.3 19:01:03 INFO - Return code: 0 19:01:03 INFO - grabbing minidump binary from tooltool 19:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:03 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 0x12e1400>, '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 0x12e23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:03 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 19:01:03 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 19:01:03 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 19:01:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:03 INFO - Return code: 0 19:01:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:01:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:03 INFO - ENV: RUST_BACKTRACE is now 1 19:01:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:01:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 19:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 19:01:03 INFO - Using env: {'DISPLAY': ':0', 19:01:03 INFO - 'HOME': '/home/cltbld', 19:01:03 INFO - 'LANG': 'en_US.UTF-8', 19:01:03 INFO - 'LANGUAGE': 'en_US:en', 19:01:03 INFO - 'LOGNAME': 'cltbld', 19:01:03 INFO - 'MAIL': '/var/mail/cltbld', 19:01:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:03 INFO - 'MOZ_NO_REMOTE': '1', 19:01:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:03 INFO - 'NO_EM_RESTART': '1', 19:01:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:03 INFO - 'PWD': '/builds/slave/test', 19:01:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:03 INFO - 'RUST_BACKTRACE': '1', 19:01:03 INFO - 'SHELL': '/bin/bash', 19:01:03 INFO - 'SHLVL': '1', 19:01:03 INFO - 'TERM': 'linux', 19:01:03 INFO - 'TMOUT': '86400', 19:01:03 INFO - 'USER': 'cltbld', 19:01:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206', 19:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:03 INFO - '_': '/tools/buildbot/bin/python'} 19:01:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 19:01:03 INFO - mozversion application_buildid: 20170323163151 19:01:03 INFO - mozversion application_changeset: 84ba19887b668b16c7d2e182f6d61524a2904b9e 19:01:03 INFO - mozversion application_display_name: Nightly 19:01:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:03 INFO - mozversion application_name: Firefox 19:01:03 INFO - mozversion application_remotingname: firefox 19:01:03 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 19:01:03 INFO - mozversion application_vendor: Mozilla 19:01:03 INFO - mozversion application_version: 55.0a1 19:01:03 INFO - mozversion platform_buildid: 20170323163151 19:01:03 INFO - mozversion platform_changeset: 84ba19887b668b16c7d2e182f6d61524a2904b9e 19:01:03 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 19:01:03 INFO - mozversion platform_version: 55.0a1 19:01:03 INFO - using testdate: 1490320863 19:01:03 INFO - actual date: 1490320863 19:01:03 INFO - starting webserver on 'localhost:52892' 19:01:03 INFO - SUITE-START | Running 2 tests 19:01:03 INFO - TEST-START | dromaeo_css 19:01:03 INFO - operating with platform_type : linux_ 19:01:03 INFO - Initialising browser for dromaeo_css test... 19:01:03 INFO - TEST-INFO | started process 12711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMTHiK/profile http://localhost:52892/getInfo.html) 19:01:04 INFO - PID 12711 | 19:01:04 INFO - PID 12711 | { 19:01:04 INFO - PID 12711 | "TopSites": { 19:01:04 INFO - PID 12711 | "rows": [ 19:01:04 INFO - PID 12711 | { 19:01:04 INFO - PID 12711 | "title": "Facebook", 19:01:04 INFO - PID 12711 | "url": "https://www.facebook.com/" 19:01:04 INFO - PID 12711 | }, 19:01:04 INFO - PID 12711 | { 19:01:04 INFO - PID 12711 | "title": "YouTube", 19:01:04 INFO - PID 12711 | "url": "https://www.youtube.com/" 19:01:04 INFO - PID 12711 | }, 19:01:04 INFO - PID 12711 | { 19:01:04 INFO - PID 12711 | "title": "Amazon", 19:01:04 INFO - PID 12711 | "url": "http://www.amazon.com/" 19:01:04 INFO - PID 12711 | }, 19:01:04 INFO - PID 12711 | { 19:01:04 INFO - PID 12711 | "title": "Yahoo", 19:01:04 INFO - PID 12711 | "url": "https://www.yahoo.com/" 19:01:04 INFO - PID 12711 | }, 19:01:04 INFO - PID 12711 | { 19:01:04 INFO - PID 12711 | "title": "eBay", 19:01:04 INFO - PID 12711 | "url": "http://www.ebay.com" 19:01:04 INFO - PID 12711 | }, 19:01:04 INFO - PID 12711 | { 19:01:04 INFO - PID 12711 | "title": "Twitter", 19:01:04 INFO - PID 12711 | "url": "https://twitter.com/" 19:01:04 INFO - PID 12711 | } 19:01:04 INFO - PID 12711 | ] 19:01:04 INFO - PID 12711 | } 19:01:04 INFO - PID 12711 | } 19:01:08 INFO - PID 12711 | __metrics Screen width/height:1600/1200 19:01:08 INFO - PID 12711 | colorDepth:24 19:01:08 INFO - PID 12711 | Browser inner width/height: 1024/697 19:01:08 INFO - PID 12711 | __metrics 19:01:09 INFO - PID 12711 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:01:09 INFO - PID 12711 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:10 INFO - TEST-INFO | 12711: exit 0 19:01:10 INFO - Browser initialized. 19:01:10 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:10 INFO - TEST-INFO | started process 12802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMTHiK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:10 INFO - PID 12802 | 19:01:10 INFO - PID 12802 | { 19:01:10 INFO - PID 12802 | "TopSites": { 19:01:10 INFO - PID 12802 | "rows": [ 19:01:10 INFO - PID 12802 | { 19:01:10 INFO - PID 12802 | "title": "Facebook", 19:01:10 INFO - PID 12802 | "url": "https://www.facebook.com/" 19:01:10 INFO - PID 12802 | }, 19:01:10 INFO - PID 12802 | { 19:01:10 INFO - PID 12802 | "title": "YouTube", 19:01:10 INFO - PID 12802 | "url": "https://www.youtube.com/" 19:01:10 INFO - PID 12802 | }, 19:01:10 INFO - PID 12802 | { 19:01:10 INFO - PID 12802 | "title": "Amazon", 19:01:10 INFO - PID 12802 | "url": "http://www.amazon.com/" 19:01:10 INFO - PID 12802 | }, 19:01:10 INFO - PID 12802 | { 19:01:10 INFO - PID 12802 | "title": "Yahoo", 19:01:10 INFO - PID 12802 | "url": "https://www.yahoo.com/" 19:01:10 INFO - PID 12802 | }, 19:01:10 INFO - PID 12802 | { 19:01:10 INFO - PID 12802 | "title": "eBay", 19:01:10 INFO - PID 12802 | "url": "http://www.ebay.com" 19:01:10 INFO - PID 12802 | }, 19:01:10 INFO - PID 12802 | { 19:01:10 INFO - PID 12802 | "title": "Twitter", 19:01:10 INFO - PID 12802 | "url": "https://twitter.com/" 19:01:10 INFO - PID 12802 | } 19:01:10 INFO - PID 12802 | ] 19:01:10 INFO - PID 12802 | } 19:01:10 INFO - PID 12802 | } 19:01:22 INFO - PID 12802 | RSS: Main: 150605824 19:01:22 INFO - PID 12802 | 19:04:28 INFO - PID 12802 | Cycle 1(1): loaded http://localhost:52892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52892/tests/dromaeo/cssquery-ext.html) 19:04:30 INFO - PID 12802 | RSS: Main: 287076352 19:04:30 INFO - PID 12802 | 19:06:12 INFO - PID 12802 | ************************* 19:06:12 INFO - PID 12802 | A coding exception was thrown and uncaught in a Task. 19:06:12 INFO - PID 12802 | 19:06:12 ERROR - PID 12802 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:06:12 INFO - PID 12802 | Full stack: 19:06:12 INFO - PID 12802 | ************************* 19:07:33 INFO - PID 12802 | Cycle 1(1): loaded http://localhost:52892/tests/dromaeo/cssquery-ext.html (next: http://localhost:52892/tests/dromaeo/cssquery-jquery.html) 19:07:33 INFO - PID 12802 | RSS: Main: 242892800 19:07:33 INFO - PID 12802 | 19:10:36 INFO - PID 12802 | Cycle 1(1): loaded http://localhost:52892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52892/tests/dromaeo/cssquery-mootools.html) 19:10:36 INFO - PID 12802 | RSS: Main: 215293952 19:10:36 INFO - PID 12802 | 19:13:39 INFO - PID 12802 | Cycle 1(1): loaded http://localhost:52892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52892/tests/dromaeo/cssquery-prototype.html) 19:13:39 INFO - PID 12802 | RSS: Main: 245080064 19:13:39 INFO - PID 12802 | 19:16:42 INFO - PID 12802 | Cycle 1(1): loaded http://localhost:52892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52892/tests/dromaeo/cssquery-yui.html) 19:16:43 INFO - PID 12802 | RSS: Main: 188510208 19:16:43 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | Cycle 1(1): loaded http://localhost:52892/tests/dromaeo/cssquery-yui.html (next: http://localhost:52892/tests/dromaeo/cssquery-dojo.html) 19:19:46 INFO - PID 12802 | RSS: Main: 278917120 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | __start_tp_report 19:19:46 INFO - PID 12802 | _x_x_mozilla_page_load 19:19:46 INFO - PID 12802 | _x_x_mozilla_page_load_details 19:19:46 INFO - PID 12802 | |i|pagename|runs| 19:19:46 INFO - PID 12802 | |0;dojo.html;2662.7204143564927;2680.128958088622;2700.378912850044;2709.7832173426127;2714.2400127964165;4983.252512123183;5054.140796064668;5140.614453915957;5152.896942061157;5192.766325515351;5080.923786143211;5112.156494178465;5140.0490909181735;5150.356205474316;5196.038732834429;4607.285870690049;4645.349651048856;4654.301854721785;4763.54746299101;4802;4734.360861283734;4771.594414474774;4783.569478746912;4790.97604511977;4793.185158523042;4550.840720574797;4608.9308660370125;4610;4657.580817726421;4721.126591580569;4624.630029597624;4632.513586073447;4644.883877903046;4686.203345431285;4710.62315014798;4559.703619264737;4599.816007359702;4606.677532572721;4609.492955774862;4644.256918892961;4984.152694042022;5001.424836143854;5074.847754567369;5082.440931497532;5133.281340612317;5421.83734487966;5515.09001014832;5560.888782224373;5566.137248726453;5574.219609254707;5545.306836645419;5556.555475561945;5564.666120032811;5568.999999999959;5572.414896435897;5161.329027226474;5161.354830646169;5166.328377311001;5170.508801663836;5181.689098654093;5438.972805135949;5455.0453670607485;5502.394736578973;5504;5507.834764957058;5332.866678332995;5334.51989320963;5338.199270109515;5339.305890234323;5348.705821179872;5382.892342153135;5524.4199359066715;5579.776808927598;5584.776608935678;5593.216949627055;5452.40023597404;5463.043967305705;5466.289382380265;5467.289252397242;5511.669299842022;5506.697131657717;5513.145462453326;5520.641158324696;5522.2544956431175;5565.16522521625;4486.461624605003;4525.637948964075;4587.7017993830295;4628.282616194495;4638.234691275969;3944.4083387491532;3946.9802650987135;3947.9802600987387;3974.105826189142;3988.6809055275507;4776.895018238173;4778.068276686083;4778.689385189951;4783.425988881357;4822.276658501182;5440;5498.230247765316;5504.779808807602;5505.504504594525;5514.779408823682;4654.488006319302;4691.225947718656;4693.319468677023;4694.765261736899;4695.577398034125;4822.156122678587;4830.227163653799;4838.540338667821;4840.515948405131;4843.2735089736825;5023.372078490262;5029.899402012013;5037.647364684437;5116.9232461512365;5123.974380128225;5514.420985796433;5528.502434780889;5528.806491772769;5528.806491772769;5534.529564987021;5099.3370861787735;5160.896782064413;5164.586833053271;5164.612654051037;5172.844814655567;5415.810446634349;5450.454954504677;5451.836444906659;5457.154141108134;5462.562994960473;5571.804986825442;5574.665520068809;5577.3028371453565;5579.302587176603;5590.161475778666;5234.659747116578;5313.229581710553;5326.334208223972;5418.160185171305;5463.644863083887;5373.838784836461;5386.299781028598;5413.783448662167;5416.214648875812;5435.021696094741;5312.920306195333;5321.042212401805;5321.255024296524;5327.227552005015;5330.093884039645;5153.433122356463;5425.728713564385;5436.891262174813;5444.945550544602;5469.945300547103;5206.661566998133;5212;5214.97392513035;5220.530152286313;5223.921641175461 19:19:46 INFO - PID 12802 | |1;ext.html;572.602041581101;624.8781487609915;642.2453617000025;964.185263452383;968.9970880139058;23427.882860585694;30759.69240307599;31379.901703440413;31392.372152556934;31396.37207255859;33167.66832331676;33500.66499335006;33559.66440335596;33581.49627755586;33597.49603755945;5591.3569939456875;7324.194338622748;7516.774496765079;7517.834735615988;7522.398208143335;5655.26481557399;7066.7173313067415;7285;7296.270372962715;7298.087739032621;7377.852442951164;7425.443091768112;7427.2201418851055;7429.294217049399;7431.516951398169;5619.353774315924;7337.156227033906;7390.963045184793;7397.075365579302;7405.777826665155;5719.456651618131;7180.964095179543;7323.890141647827;7334.413246940232;7341.52280101797;30288.394232115454;30708;30719.078427647208;30723;30778.53832192519;2619;2638.103044964702;2647.3116989582845;2648.47030593882;2733.7812974961957;21436.24973125933;21609.891950540303;21746.56506869854;21776.564468710538;22101.66847497289;2558.9616155757494;2561.654176686161;2565.2817211180713;2580.1743442098536;2748.1206014075506;118721.99999999914;118777.40611296975;118818.40590797077;119207;119336;37448.62551374506;37558.62441375606;40777.796111019255;40885;41016.179676406304;42557.44655320629;42577.148457031304;42582.78708606499;42634.360484592755;42696.57303426988;12891.806622900664;13373.398197081155;13376;13391.531296404579;13406.329683515785;8792.47245165292;8950.14973577509;10727.249092563447;10737.51681174349;10741.946290268499;12424.56514022023;12558.560450384193;12697.111202215941;12733;12757.617271481871;4545.795439205243;4582.9312560310955;4585.770711464414;4594.218982772936;4679.21586655946;864.9524276164872;870.8345414371375;876.1632640827994;879.0111124984393;902.9548522573845;20215.393538193584;21059.473513162295;21096.789032109482;21280.893595531925;21358.679619805716;942.641796117471;943.118184497497;946.394307643109;968.7481254873784;974.9707508774607;10947.686436635338;11457.14071444645;11460.942695286636;11479.655610331703;11482.0814334853;236987;238763;239103;239711;239747;42657.57342426598;43101.78449107734;43134.78432607817;43178.307362358886;43184.54523638101;1155.0990227622467;1199.1366216324407;1200.3518100225954;1202.6211743300832;1214.7631211913592;19835.702464462756;19991.20035198634;20019.699704504153;20765.60094375443;20914.477138071063;29809.403811924072;38480;39261;39280.410793837545;39283;254392.82428702645;256676;256759;256893;257696;22763;23025.309240722807;30426;30674.539881902234;30849.537256941614;25978;31306.530402044442;31919;32013.67986320107;32287.838560807046;25893.223203303933;26288.211353659422;26517.07190248332;26730.866345668925;27128.864355678095;25972.35069123287;26007.349816253987;26042.73957260479;26372;27223.04719334814;29300.267493312836;29350.266243344086;29495;29495.85252073726;29504.557431638113;25694.357641059123;25766.355841104123;25855;26838.194854154408;27128.050518232558;20123.597528049064;21148.894255529238;21249.150033998467;21392.893035535344;21396.251131210334 19:19:46 INFO - PID 12802 | |2;jquery.html;401.09953155166636;410.9213315047999;414.3577454944836;424.3168498717065;431.66545926906645;11635.360055196981;15804.920975395107;17083.743743843854;17713.911430442848;17731.73402398965;17391;17636.118194090275;18135;18995.145218465168;19124.713129303072;5563.193336966147;5748.109043098306;5939.376365481627;6181.783637572686;6232.9376706232815;3611.1513794258326;6255.59338642989;6299.464545513637;6303.968480157616;6310;3978.8209530571194;6283.937160628404;6306.968465157668;6309.652969086698;6351.9682401587925;6054.303755068179;6140.723667434976;6228.844278893019;6283.434490895818;6300.716467758962;6075.088736689488;6080;6176.69116544171;6181.07283907413;6187.907181392283;23373;24134.758652413428;24473;24601.539846015436;24697.135600254085;1589.5628702106897;1610.6537094524617;1616.8140663823692;1658.983410165895;1660.2279939828038;14745.262736863222;14912.776308355384;15374.308156132889;15824;16221.756673649905;1727.2054854766823;1771.4597047900386;1781.6436712657392;1817.500187448449;1818.9090545472807;69263.65368173177;77860;86243.56878215632;87154;89430.552847236;17350;17497.30010799554;17587.208575614128;17786.5553361167;18026.188821503063;25527;32525.837370813468;32614.67385326164;32632;32878;8591.871121933176;8660.39377243587;8797.824043519095;9183.724488265363;9433.716988490356;7020.824479387954;7121.252268511836;7137.643117844087;7307.415406767446;7365.594892280868;9305.627774888928;9390.85913711295;9431.952840235756;9433.669821556212;9458.52707364629;3475.7740746851373;3549.432090865449;3749.737518373742;3871.922561548753;3969.3053715599654;805.8952336196375;845.7716416567492;847.7287268074157;854.7350321400386;859.1151114352227;16590.419335323448;17487.475375738493;17732.556686082695;17791.377301794375;18554.350597729015;857.2199298638209;863.8533244886452;865.6926790989235;872.9519876406858;883.8099808541066;8834.95582522096;9658.323917325719;9687.370320929118;9726.854097188549;9755.317127801127;503331;504391;506406;507183.13802343217;515752;86423;87747.12252877517;88307;89635.55182224046;93414.06585934054;1099.6206308823444;1100.8568886044923;1109.916756243285;1114.025227925565;1115.8772535021142;14913.3289001993;14972.326245318769;15000.174990375634;15186.24068796578;15486.225688715294;26857.452423671242;40692.1861562773;41453.58546414497;42473.36289955591;42652.86735663266;50475.466717330906;50591;50783;51023.48976510188;53756.46243537671;7700.383969282556;7712;7758.107817600822;7783.649735762017;7941.324987376138;11116.610918618133;11139.83290250663;11161.772205057276;11246.887531124585;11522.42387880586;10033.498325083863;10202.540885660312;10214.69355919294;10373.481325933522;10452.634157804441;8535.786605334917;9238.399504032217;9739.415635061636;9768.267379946674;9981.401115933068;9308.627654893728;9646.951765241129;9832.16426603718;9968.102870741668;10316.638917637847;7532.962335188289;7991.800204994922;8023.916771236042;8211.096779354148;8224.753257402288;10518.947405262925;10717.410542420243;10752.354858708502;10978.780424391627;11231.775364492827 19:19:46 INFO - PID 12802 | |3;mootools.html;1226.7546490701861;1269.4351013798857;1282.3075539208828;1288.1884412819923;1294.8057791331296;9263.722088337343;9613.951930240357;9626.085521875428;9644.710658680233;9649.372790768595;9603.375780574257;9894.554745036472;9942.751431214223;9954.601815927354;9963.950180249089;2122.586095711337;2155.2241193170526;2158.6006588781124;2158.881261530615;2159.3953692965993;1818.9818101818944;2070.109852763311;2116.2064225915283;2122.660374340106;2174.891255437222;1871.101871101872;2085.947851303722;2157.46063484129;2158.7841215878443;2168.2519530761942;2054.9280775172947;2079.085202510898;2079.6672532394896;2085.582883423306;2086.301089135149;2036.867603605761;2040.7245021922;2042.9795702042939;2044.1618936236073;2049.1496029147884;9535.141837234612;9638.71083867478;9657.420554766737;9663.951680241624;9671.226301895831;4950.381202349707;5226.242194881721;5226.92159617606;5236.842894713165;5239.187925871458;2974.762019038472;3041.148478426044;3285.704286614216;3295.571575695168;3295.7692961492703;997.5610731278286;997.7156510394502;998.3211416236956;1042.6142327338857;1056.5245639462273;13715.862841371558;14177.645558861112;14354.425822967174;14538.70922581553;14555.490557830424;4670.6497012724185;4783.425988881357;4790.377250957423;4827.61379089672;4836.758162091952;10765.3540787553;10769.515371808287;10774.084202842847;11145;11167.72080697989;5253.448387919213;5257.921131183035;5265.657732247391;5268.130758424893;5270.8945821084135;4669.252919532859;4726.763661816895;4799.472058073609;4799.832005879847;4802.183628783116;3538.6284440133413;3687.5574931007914;3698.7410881238593;3750.1187221003042;3761.3041587306434;962.1965658675085;1091.0725882999545;1098.609993452313;1114.554178328675;1115.4813011949482;583.76941108262;656.5765081522392;685.9657017149123;694.9687264073128;735.0884902720695;4883.4628190898975;5213.478652134832;5219.791208351699;5222.817201397933;5388.9730551347775;812.5327936436572;823.7322870067132;831.846108469935;833.8123922117596;851.7402192331275;3612.6206748291575;3665.9266814664093;3724.832382542792;3744.7753134811996;3835.7314987951136;12416.627501174979;12997.935010324887;13009.284489352987;13010.21938683682;13014.479420823061;12915.677108072374;12918.935405322913;12921.418536165895;12928;12936.870631293756;8899.688510902217;9275.397099188665;9279.72160835176;9282.860757088649;9298.209652179505;5958.523318134452;6014.9097763534455;6103.9285179454255;6105.755769769159;6336.714847831767;11530.884691152982;11779.823302650295;11837.691650128143;11843.348615826213;12134.393280336124;11650.592229272273;12047.939760301142;12166.209196402206;12169.20900141488;12191.207571507824;8069.3544516439715;8331.125231850569;8348.165183481604;8348.499090054373;8355.080941096354;9263.814723705624;9297.72106836796;9418.95290523543;9493.098155675476;9540.379875308083;7877.6455059523605;7944.245296696805;7987.241212084843;8015.078265999251;8160.673573057011;7212.675429605575;7236.078166714661;7242.637868106679;7370.742024029133;7468.7759367216895;6832.248452670103;6839.281875403011;6842.623655698785;6896.517243792886;6901.482388820758;4611.907761844677;4627.398438203012;4918.409790825124;5074.238864170404;5086.338775959101;4854.75726213695;4962.528559786814;5000.899982000266;5048.495150485069;5125.820596279113 19:19:46 INFO - PID 12802 | |4;prototype.html;361.5877899194918;380.8305304139659;388.68516501633695;391.9921601567969;394.9328614135597;5313.176457649066;5365.168398898168;5369.301990741203;5386.703731294782;5409.6213265071465;5241.6191556446065;5299.231611416342;5311.1502159654465;5319.654222475537;5324.949894290697;4030.234255491447;4062.370332598452;4085.7957102144924;4245.7240279381895;4296.935545966813;4106.691998100139;4120.876373708778;4123.649489793356;4123.97938010311;4127.566605506424;4091.8158682859344;4096.528899176588;4097.569755175708;4097.856575019875;4117.938230926538;3857.167845273501;4087.713860029799;4095.0786073133604;4108.897277568055;4120.62914337708;3539.52216450781;3579.0873327301633;3585.713142948558;3595.1012246938267;3607.134287770942;5159.69041857486;5182.870428239286;5187.507186817246;5189.974050129763;5211.530962213381;4705.106029854351;4729.266963620645;4733.834315798965;4736.786844592001;4744.16977029022;5432.402435732066;5608.4391560844;5640.351359593658;5646.124850648156;5648.068068768689;3974.5429275633383;3979.1047014421815;3983.820728067244;3991.980040099781;3996.8800935971967;5652.428145193927;5678.801241956512;5798.42015798421;5869.8239052828485;5977.701114944235;4025.6376926076796;4041.191761647682;4049.817758200888;4052.169305292408;4057.0871553900724;4071.75569465833;4115.32097203964;4119.258533463945;4124.092699606142;4139.97930010348;4385.6710746694125;4474;4505.5719706627815;4739.549742774431;4746;5473.589480788957;5516.117421212587;5526.336839579276;5609.523190528769;5640.746166422521;1399.971021299344;1416.8795652369663;1422.345720968366;1423.4306277489088;1428.9356978935973;908.2779190543533;948.3977674176947;956.7368973532334;962.6390103711109;968.1045033344128;4928.186849169919;4928.704277743347;4929.852104436873;4933.087378834927;4948.802047918115;5764.510016648548;5800.187973683687;5804.158397032406;5812.796552120655;5820.330661973842;4834.694632449289;4899.4365647950945;4935.679180853233;4960.817240414206;4966.8758281043265;3054.1906394805396;3086.4135814195233;3087.5368694695526;3096.969030309713;3101.3022070034062;5397.703126328011;5401.648892821954;5402.540784033323;5406.378266499403;5427.240186373911;5811.88376232473;5937.70311484424;5948.196993405922;5954.910676339859;5958.821235362946;5372.5701943843615;5375.919361209585;5388.9730551347775;5399;5402.459754024566;5560.221568980265;5794.565407594531;5800.4489573490455;5811.86668599619;5836;5696.886062278814;5730.598858079894;5738.626989245853;5757.8560535986935;5760.790234050896;5126.384833819965;5225.372955245395;5312.946870531246;5348.545373643284;5406.972965135149;4025.2150830587752;4041.8787436376956;4042.3532234842282;4043.6765058795813;4050.8784736457956;5771.163181338598;5773.393793651606;5789.739461724148;5798.56510761703;5824.835032993334;5420.241166236651;5579.637323573955;5603.943960560342;5613.382527922007;5625.831225063254;5588.357338905916;5594.188842617717;5604.8318550443555;5620.241267428844;5635.154726791015;5389.865253368697;5526.585506086979;5530.7511161997;5545.639533430314;5573.554115670656;5609.971950140223;5627.184058311604;5641.858953526031;5646.8706258749235;5667.263255776723;5484.8354549363585;5500.697461639648;5501.229827824188;5522;5523.696196709219 19:19:46 INFO - PID 12802 | |5;yui.html;632.6963057732288;647.1877793369321;661.2329697550842;676.3675962974617;679.3410391919836;10795.56817727291;11352.545898164073;11372.147088968319;11382.544698212072;11383.772324553503;11156.274842135255;11335.149863760209;11509.30944143352;11685.182037257395;11877.703057423569;809.8015986083418;821.289584509401;822.62159406673;822.7408366364606;826.1366871619173;795.6499140378215;817.1175130858688;819.2544784246337;819.4264015189361;828.349745449822;856.8072183758636;863.2791618998144;863.8401895649325;865.1867244789909;865.6364326982682;855.6791203298762;856.2892798976897;856.5075081827974;856.9314454843598;857.6998050682242;632.0771673356904;633.4520639646672;633.4583930739244;633.6324931539696;633.8130251575797;13051.086423950328;13404.262765547892;13446.79829802544;13453.932730336286;13592.11651242666;13367.665808354772;13979.79030314546;14136.182794098631;14204.57386278403;14369.209693466959;9017.7821721179;9383.812323753487;9742.366746161548;9778.804423911482;9921.85117223235;2506.5362907862104;2512.133314006665;2535.6703628528358;2551.4641925195733;2580.36780988659;63474;63641.681791590745;64444.67777661129;65039.67480162616;65930.67034664843;10337.586496540205;10655.094316982988;10710.839337409945;10732.678019659423;10966.451677416097;19451.416457506297;19659.803401966084;19680.803191967898;19698;19836.10737516815;6504.739810407531;6534.673266336664;6541.215054193527;6561.5734977227285;6774.288699686561;3343.5653365062385;3381.1040074380307;3391.6099648540735;3438.3123375325035;3457.083872773717;3204.3110731192437;3235.563198968156;3247.8863239786965;3267.39553182662;3287.3260981498734;623.5323507369473;624.3912185619076;631.8167731357946;640.1741753138399;647.9740810367626;520.60608464559;541.5667466027163;549.1159233633846;549.5219159331327;551.5615086006634;7989.880151797728;8085;8116.443320354069;8175.305099066646;8182.590870456573;462.70155749541357;481.30691803802415;486.7858142417325;488.9193283108247;492.55423841423567;3604.279144171176;3614.945775813365;3621.257642183346;3703.6851867591017;3726.7950262735267;56211.43788562144;56414;56988.43011569914;57341.713291433276;57881;51009;51485.227721584204;51857.2221416679;52179.73910130425;53359.46640533623;47856.5214347859;47860.760696196296;48371.5162848367;48760.51239487559;48889.511104888494;7231.819204519929;7278.454115941219;7317.597532135784;7404;7642.312191902755;25212.873935630203;25566.61650075213;25993.22020339393;26187.738122619292;26716.465670686866;30187.547186791777;30200.5469917947;30236.84881575578;30393.696063039086;30450.238744030692;9359.532023398939;9367.906320936703;9427.15155635996;9518.762030949281;9597.23222142213;9704.70885873425;9720.160536587866;9929.950350248202;10019.448930308612;10119.949400252952;8933.731988040368;8937.553122343987;9100.271978241857;9103.135202155785;9454.905450945678;9426.905730942603;9904.158146557624;10023.949880250844;10203.03071208234;10299.124574411258;8972.81956118309;9392.248620110511;9415.340926135104;9502.097300756417;9665;6348.111264423077;6448.838779030374;6589.110470086477;6652.600843949379;6785.389314961677;7269.55394320202;7501.549907005598;7677.500962437423;7773.883391749016;8147.063087744985 19:19:46 INFO - PID 12802 | __end_tp_report 19:19:46 INFO - PID 12802 | __start_cc_report 19:19:46 INFO - PID 12802 | _x_x_mozilla_cycle_collect,1676 19:19:46 INFO - PID 12802 | __end_cc_report 19:19:46 INFO - PID 12802 | __startTimestamp1490321986923__endTimestamp 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | ------- Summary: start ------- 19:19:46 INFO - PID 12802 | Number of tests: 6 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | [#0] dojo.html Cycles:165 Average:5052.98 Median:5172.84 stddev:572.01 (11.1%) stddev-sans-first:542.16 19:19:46 INFO - PID 12802 | Values: 2662.7 2680.1 2700.4 2709.8 2714.2 4983.3 5054.1 5140.6 5152.9 5192.8 5080.9 5112.2 5140.0 5150.4 5196.0 4607.3 4645.3 4654.3 4763.5 4802.0 4734.4 4771.6 4783.6 4791.0 4793.2 4550.8 4608.9 4610.0 4657.6 4721.1 4624.6 4632.5 4644.9 4686.2 4710.6 4559.7 4599.8 4606.7 4609.5 4644.3 4984.2 5001.4 5074.8 5082.4 5133.3 5421.8 5515.1 5560.9 5566.1 5574.2 5545.3 5556.6 5564.7 5569.0 5572.4 5161.3 5161.4 5166.3 5170.5 5181.7 5439.0 5455.0 5502.4 5504.0 5507.8 5332.9 5334.5 5338.2 5339.3 5348.7 5382.9 5524.4 5579.8 5584.8 5593.2 5452.4 5463.0 5466.3 5467.3 5511.7 5506.7 5513.1 5520.6 5522.3 5565.2 4486.5 4525.6 4587.7 4628.3 4638.2 3944.4 3947.0 3948.0 3974.1 3988.7 4776.9 4778.1 4778.7 4783.4 4822.3 5440.0 5498.2 5504.8 5505.5 5514.8 4654.5 4691.2 4693.3 4694.8 4695.6 4822.2 4830.2 4838.5 4840.5 4843.3 5023.4 5029.9 5037.6 5116.9 5124.0 5514.4 5528.5 5528.8 5528.8 5534.5 5099.3 5160.9 5164.6 5164.6 5172.8 5415.8 5450.5 5451.8 5457.2 5462.6 5571.8 5574.7 5577.3 5579.3 5590.2 5234.7 5313.2 5326.3 5418.2 5463.6 5373.8 5386.3 5413.8 5416.2 5435.0 5312.9 5321.0 5321.3 5327.2 5330.1 5153.4 5425.7 5436.9 5444.9 5469.9 5206.7 5212.0 5215.0 5220.5 5223.9 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | [#1] ext.html Cycles:180 Average:33826.93 Median:29500.20 stddev:56104.57 (190.2%) stddev-sans-first:56206.40 19:19:46 INFO - PID 12802 | Values: 572.6 624.9 642.2 964.2 969.0 23427.9 30759.7 31379.9 31392.4 31396.4 33167.7 33500.7 33559.7 33581.5 33597.5 5591.4 7324.2 7516.8 7517.8 7522.4 5655.3 7066.7 7285.0 7296.3 7298.1 7377.9 7425.4 7427.2 7429.3 7431.5 5619.4 7337.2 7391.0 7397.1 7405.8 5719.5 7181.0 7323.9 7334.4 7341.5 30288.4 30708.0 30719.1 30723.0 30778.5 2619.0 2638.1 2647.3 2648.5 2733.8 21436.2 21609.9 21746.6 21776.6 22101.7 2559.0 2561.7 2565.3 2580.2 2748.1 118722.0 118777.4 118818.4 119207.0 119336.0 37448.6 37558.6 40777.8 40885.0 41016.2 42557.4 42577.1 42582.8 42634.4 42696.6 12891.8 13373.4 13376.0 13391.5 13406.3 8792.5 8950.1 10727.2 10737.5 10741.9 12424.6 12558.6 12697.1 12733.0 12757.6 4545.8 4582.9 4585.8 4594.2 4679.2 865.0 870.8 876.2 879.0 903.0 20215.4 21059.5 21096.8 21280.9 21358.7 942.6 943.1 946.4 968.7 975.0 10947.7 11457.1 11460.9 11479.7 11482.1 236987.0 238763.0 239103.0 239711.0 239747.0 42657.6 43101.8 43134.8 43178.3 43184.5 1155.1 1199.1 1200.4 1202.6 1214.8 19835.7 19991.2 20019.7 20765.6 20914.5 29809.4 38480.0 39261.0 39280.4 39283.0 254392.8 256676.0 256759.0 256893.0 257696.0 22763.0 23025.3 30426.0 30674.5 30849.5 25978.0 31306.5 31919.0 32013.7 32287.8 25893.2 26288.2 26517.1 26730.9 27128.9 25972.4 26007.3 26042.7 26372.0 27223.0 29300.3 29350.3 29495.0 29495.9 29504.6 25694.4 25766.4 25855.0 26838.2 27128.1 20123.6 21148.9 21249.2 21392.9 21396.3 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | [#2] jquery.html Cycles:180 Average:29635.92 Median:50533.23 stddev:83432.36 (165.1%) stddev-sans-first:83637.53 19:19:46 INFO - PID 12802 | Values: 401.1 410.9 414.4 424.3 431.7 11635.4 15804.9 17083.7 17713.9 17731.7 17391.0 17636.1 18135.0 18995.1 19124.7 5563.2 5748.1 5939.4 6181.8 6232.9 3611.2 6255.6 6299.5 6304.0 6310.0 3978.8 6283.9 6307.0 6309.7 6352.0 6054.3 6140.7 6228.8 6283.4 6300.7 6075.1 6080.0 6176.7 6181.1 6187.9 23373.0 24134.8 24473.0 24601.5 24697.1 1589.6 1610.7 1616.8 1659.0 1660.2 14745.3 14912.8 15374.3 15824.0 16221.8 1727.2 1771.5 1781.6 1817.5 1818.9 69263.7 77860.0 86243.6 87154.0 89430.6 17350.0 17497.3 17587.2 17786.6 18026.2 25527.0 32525.8 32614.7 32632.0 32878.0 8591.9 8660.4 8797.8 9183.7 9433.7 7020.8 7121.3 7137.6 7307.4 7365.6 9305.6 9390.9 9432.0 9433.7 9458.5 3475.8 3549.4 3749.7 3871.9 3969.3 805.9 845.8 847.7 854.7 859.1 16590.4 17487.5 17732.6 17791.4 18554.4 857.2 863.9 865.7 873.0 883.8 8835.0 9658.3 9687.4 9726.9 9755.3 503331.0 504391.0 506406.0 507183.1 515752.0 86423.0 87747.1 88307.0 89635.6 93414.1 1099.6 1100.9 1109.9 1114.0 1115.9 14913.3 14972.3 15000.2 15186.2 15486.2 26857.5 40692.2 41453.6 42473.4 42652.9 50475.5 50591.0 50783.0 51023.5 53756.5 7700.4 7712.0 7758.1 7783.6 7941.3 11116.6 11139.8 11161.8 11246.9 11522.4 10033.5 10202.5 10214.7 10373.5 10452.6 8535.8 9238.4 9739.4 9768.3 9981.4 9308.6 9647.0 9832.2 9968.1 10316.6 7533.0 7991.8 8023.9 8211.1 8224.8 10518.9 10717.4 10752.4 10978.8 11231.8 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | [#3] mootools.html Cycles:180 Average:6111.43 Median:4814.90 stddev:3962.01 (82.3%) stddev-sans-first:3956.12 19:19:46 INFO - PID 12802 | Values: 1226.8 1269.4 1282.3 1288.2 1294.8 9263.7 9614.0 9626.1 9644.7 9649.4 9603.4 9894.6 9942.8 9954.6 9964.0 2122.6 2155.2 2158.6 2158.9 2159.4 1819.0 2070.1 2116.2 2122.7 2174.9 1871.1 2085.9 2157.5 2158.8 2168.3 2054.9 2079.1 2079.7 2085.6 2086.3 2036.9 2040.7 2043.0 2044.2 2049.1 9535.1 9638.7 9657.4 9664.0 9671.2 4950.4 5226.2 5226.9 5236.8 5239.2 2974.8 3041.1 3285.7 3295.6 3295.8 997.6 997.7 998.3 1042.6 1056.5 13715.9 14177.6 14354.4 14538.7 14555.5 4670.6 4783.4 4790.4 4827.6 4836.8 10765.4 10769.5 10774.1 11145.0 11167.7 5253.4 5257.9 5265.7 5268.1 5270.9 4669.3 4726.8 4799.5 4799.8 4802.2 3538.6 3687.6 3698.7 3750.1 3761.3 962.2 1091.1 1098.6 1114.6 1115.5 583.8 656.6 686.0 695.0 735.1 4883.5 5213.5 5219.8 5222.8 5389.0 812.5 823.7 831.8 833.8 851.7 3612.6 3665.9 3724.8 3744.8 3835.7 12416.6 12997.9 13009.3 13010.2 13014.5 12915.7 12918.9 12921.4 12928.0 12936.9 8899.7 9275.4 9279.7 9282.9 9298.2 5958.5 6014.9 6103.9 6105.8 6336.7 11530.9 11779.8 11837.7 11843.3 12134.4 11650.6 12047.9 12166.2 12169.2 12191.2 8069.4 8331.1 8348.2 8348.5 8355.1 9263.8 9297.7 9419.0 9493.1 9540.4 7877.6 7944.2 7987.2 8015.1 8160.7 7212.7 7236.1 7242.6 7370.7 7468.8 6832.2 6839.3 6842.6 6896.5 6901.5 4611.9 4627.4 4918.4 5074.2 5086.3 4854.8 4962.5 5000.9 5048.5 5125.8 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | [#4] prototype.html Cycles:180 Average:4636.09 Median:5313.06 stddev:1352.73 (25.5%) stddev-sans-first:1317.93 19:19:46 INFO - PID 12802 | Values: 361.6 380.8 388.7 392.0 394.9 5313.2 5365.2 5369.3 5386.7 5409.6 5241.6 5299.2 5311.2 5319.7 5324.9 4030.2 4062.4 4085.8 4245.7 4296.9 4106.7 4120.9 4123.6 4124.0 4127.6 4091.8 4096.5 4097.6 4097.9 4117.9 3857.2 4087.7 4095.1 4108.9 4120.6 3539.5 3579.1 3585.7 3595.1 3607.1 5159.7 5182.9 5187.5 5190.0 5211.5 4705.1 4729.3 4733.8 4736.8 4744.2 5432.4 5608.4 5640.4 5646.1 5648.1 3974.5 3979.1 3983.8 3992.0 3996.9 5652.4 5678.8 5798.4 5869.8 5977.7 4025.6 4041.2 4049.8 4052.2 4057.1 4071.8 4115.3 4119.3 4124.1 4140.0 4385.7 4474.0 4505.6 4739.5 4746.0 5473.6 5516.1 5526.3 5609.5 5640.7 1400.0 1416.9 1422.3 1423.4 1428.9 908.3 948.4 956.7 962.6 968.1 4928.2 4928.7 4929.9 4933.1 4948.8 5764.5 5800.2 5804.2 5812.8 5820.3 4834.7 4899.4 4935.7 4960.8 4966.9 3054.2 3086.4 3087.5 3097.0 3101.3 5397.7 5401.6 5402.5 5406.4 5427.2 5811.9 5937.7 5948.2 5954.9 5958.8 5372.6 5375.9 5389.0 5399.0 5402.5 5560.2 5794.6 5800.4 5811.9 5836.0 5696.9 5730.6 5738.6 5757.9 5760.8 5126.4 5225.4 5312.9 5348.5 5407.0 4025.2 4041.9 4042.4 4043.7 4050.9 5771.2 5773.4 5789.7 5798.6 5824.8 5420.2 5579.6 5603.9 5613.4 5625.8 5588.4 5594.2 5604.8 5620.2 5635.2 5389.9 5526.6 5530.8 5545.6 5573.6 5610.0 5627.2 5641.9 5646.9 5667.3 5484.8 5500.7 5501.2 5522.0 5523.7 19:19:46 INFO - PID 12802 | 19:19:46 INFO - PID 12802 | [#5] yui.html Cycles:180 Average:13094.18 Median:623.96 stddev:16598.80 (2660.2%) stddev-sans-first:16618.99 19:19:46 INFO - PID 12802 | Values: 632.7 647.2 661.2 676.4 679.3 10795.6 11352.5 11372.1 11382.5 11383.8 11156.3 11335.1 11509.3 11685.2 11877.7 809.8 821.3 822.6 822.7 826.1 795.6 817.1 819.3 819.4 828.3 856.8 863.3 863.8 865.2 865.6 855.7 856.3 856.5 856.9 857.7 632.1 633.5 633.5 633.6 633.8 13051.1 13404.3 13446.8 13453.9 13592.1 13367.7 13979.8 14136.2 14204.6 14369.2 9017.8 9383.8 9742.4 9778.8 9921.9 2506.5 2512.1 2535.7 2551.5 2580.4 63474.0 63641.7 64444.7 65039.7 65930.7 10337.6 10655.1 10710.8 10732.7 10966.5 19451.4 19659.8 19680.8 19698.0 19836.1 6504.7 6534.7 6541.2 6561.6 6774.3 3343.6 3381.1 3391.6 3438.3 3457.1 3204.3 3235.6 3247.9 3267.4 3287.3 623.5 624.4 631.8 640.2 648.0 520.6 541.6 549.1 549.5 551.6 7989.9 8085.0 8116.4 8175.3 8182.6 462.7 481.3 486.8 488.9 492.6 3604.3 3614.9 3621.3 3703.7 3726.8 56211.4 56414.0 56988.4 57341.7 57881.0 51009.0 51485.2 51857.2 52179.7 53359.5 47856.5 47860.8 48371.5 48760.5 48889.5 7231.8 7278.5 7317.6 7404.0 7642.3 25212.9 25566.6 25993.2 26187.7 26716.5 30187.5 30200.5 30236.8 30393.7 30450.2 9359.5 9367.9 9427.2 9518.8 9597.2 9704.7 9720.2 9930.0 10019.4 10119.9 8933.7 8937.6 9100.3 9103.1 9454.9 9426.9 9904.2 10023.9 10203.0 10299.1 8972.8 9392.2 9415.3 9502.1 9665.0 6348.1 6448.8 6589.1 6652.6 6785.4 7269.6 7501.5 7677.5 7773.9 8147.1 19:19:46 INFO - PID 12802 | -------- Summary: end -------- 19:19:46 INFO - PID 12802 | 19:19:47 INFO - TEST-INFO | 12802: exit 0 19:19:47 INFO - TEST-OK | dromaeo_css | took 1124269ms 19:19:47 INFO - TEST-START | kraken 19:19:47 INFO - operating with platform_type : linux_ 19:19:47 INFO - Initialising browser for kraken test... 19:19:47 INFO - TEST-INFO | started process 13126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKwwDip/profile http://localhost:52892/getInfo.html) 19:19:48 INFO - PID 13126 | 19:19:48 INFO - PID 13126 | { 19:19:48 INFO - PID 13126 | "TopSites": { 19:19:48 INFO - PID 13126 | "rows": [ 19:19:48 INFO - PID 13126 | { 19:19:48 INFO - PID 13126 | "title": "Facebook", 19:19:48 INFO - PID 13126 | "url": "https://www.facebook.com/" 19:19:48 INFO - PID 13126 | }, 19:19:48 INFO - PID 13126 | { 19:19:48 INFO - PID 13126 | "title": "YouTube", 19:19:48 INFO - PID 13126 | "url": "https://www.youtube.com/" 19:19:48 INFO - PID 13126 | }, 19:19:48 INFO - PID 13126 | { 19:19:48 INFO - PID 13126 | "title": "Amazon", 19:19:48 INFO - PID 13126 | "url": "http://www.amazon.com/" 19:19:48 INFO - PID 13126 | }, 19:19:48 INFO - PID 13126 | { 19:19:48 INFO - PID 13126 | "title": "Yahoo", 19:19:48 INFO - PID 13126 | "url": "https://www.yahoo.com/" 19:19:48 INFO - PID 13126 | }, 19:19:48 INFO - PID 13126 | { 19:19:48 INFO - PID 13126 | "title": "eBay", 19:19:48 INFO - PID 13126 | "url": "http://www.ebay.com" 19:19:48 INFO - PID 13126 | }, 19:19:48 INFO - PID 13126 | { 19:19:48 INFO - PID 13126 | "title": "Twitter", 19:19:48 INFO - PID 13126 | "url": "https://twitter.com/" 19:19:48 INFO - PID 13126 | } 19:19:48 INFO - PID 13126 | ] 19:19:48 INFO - PID 13126 | } 19:19:48 INFO - PID 13126 | } 19:19:52 INFO - PID 13126 | __metrics Screen width/height:1600/1200 19:19:52 INFO - PID 13126 | colorDepth:24 19:19:52 INFO - PID 13126 | Browser inner width/height: 1024/697 19:19:52 INFO - PID 13126 | __metrics 19:19:53 INFO - PID 13126 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:19:53 INFO - PID 13126 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:54 INFO - TEST-INFO | 13126: exit 0 19:19:54 INFO - Browser initialized. 19:19:54 INFO - Running cycle 1/1 for kraken test... 19:19:54 INFO - TEST-INFO | started process 13223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKwwDip/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:55 INFO - PID 13223 | 19:19:55 INFO - PID 13223 | { 19:19:55 INFO - PID 13223 | "TopSites": { 19:19:55 INFO - PID 13223 | "rows": [ 19:19:55 INFO - PID 13223 | { 19:19:55 INFO - PID 13223 | "title": "Facebook", 19:19:55 INFO - PID 13223 | "url": "https://www.facebook.com/" 19:19:55 INFO - PID 13223 | }, 19:19:55 INFO - PID 13223 | { 19:19:55 INFO - PID 13223 | "title": "YouTube", 19:19:55 INFO - PID 13223 | "url": "https://www.youtube.com/" 19:19:55 INFO - PID 13223 | }, 19:19:55 INFO - PID 13223 | { 19:19:55 INFO - PID 13223 | "title": "Amazon", 19:19:55 INFO - PID 13223 | "url": "http://www.amazon.com/" 19:19:55 INFO - PID 13223 | }, 19:19:55 INFO - PID 13223 | { 19:19:55 INFO - PID 13223 | "title": "Yahoo", 19:19:55 INFO - PID 13223 | "url": "https://www.yahoo.com/" 19:19:55 INFO - PID 13223 | }, 19:19:55 INFO - PID 13223 | { 19:19:55 INFO - PID 13223 | "title": "eBay", 19:19:55 INFO - PID 13223 | "url": "http://www.ebay.com" 19:19:55 INFO - PID 13223 | }, 19:19:55 INFO - PID 13223 | { 19:19:55 INFO - PID 13223 | "title": "Twitter", 19:19:55 INFO - PID 13223 | "url": "https://twitter.com/" 19:19:55 INFO - PID 13223 | } 19:19:55 INFO - PID 13223 | ] 19:19:55 INFO - PID 13223 | } 19:19:55 INFO - PID 13223 | } 19:20:06 INFO - PID 13223 | RSS: Main: 150589440 19:20:06 INFO - PID 13223 | 19:20:09 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52892/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:10 INFO - PID 13223 | RSS: Main: 205721600 19:20:10 INFO - PID 13223 | 19:20:13 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52892/tests/kraken/driver.html?testName=audio-dft) 19:20:13 INFO - PID 13223 | RSS: Main: 184467456 19:20:13 INFO - PID 13223 | 19:20:16 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52892/tests/kraken/driver.html?testName=audio-fft) 19:20:17 INFO - PID 13223 | RSS: Main: 267268096 19:20:17 INFO - PID 13223 | 19:20:19 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52892/tests/kraken/driver.html?testName=audio-oscillator) 19:20:20 INFO - PID 13223 | RSS: Main: 177942528 19:20:20 INFO - PID 13223 | 19:20:22 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:23 INFO - PID 13223 | RSS: Main: 181166080 19:20:23 INFO - PID 13223 | 19:20:26 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52892/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:26 INFO - PID 13223 | RSS: Main: 220119040 19:20:26 INFO - PID 13223 | 19:20:30 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52892/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:31 INFO - PID 13223 | RSS: Main: 215842816 19:20:31 INFO - PID 13223 | 19:20:34 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52892/tests/kraken/driver.html?testName=json-parse-financial) 19:20:34 INFO - PID 13223 | RSS: Main: 217800704 19:20:34 INFO - PID 13223 | 19:20:36 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:37 INFO - PID 13223 | RSS: Main: 181006336 19:20:37 INFO - PID 13223 | 19:20:38 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:39 INFO - PID 13223 | RSS: Main: 187994112 19:20:39 INFO - PID 13223 | 19:20:41 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:42 INFO - PID 13223 | RSS: Main: 196898816 19:20:42 INFO - PID 13223 | 19:20:45 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:45 INFO - PID 13223 | RSS: Main: 201179136 19:20:45 INFO - PID 13223 | 19:20:49 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:49 INFO - PID 13223 | RSS: Main: 202919936 19:20:49 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | Cycle 1(1): loaded http://localhost:52892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52892/tests/kraken/driver.html?testName=ai-astar) 19:20:51 INFO - PID 13223 | RSS: Main: 272351232 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | __start_tp_report 19:20:51 INFO - PID 13223 | _x_x_mozilla_page_load 19:20:51 INFO - PID 13223 | _x_x_mozilla_page_load_details 19:20:51 INFO - PID 13223 | |i|pagename|runs| 19:20:51 INFO - PID 13223 | |0;ai-astar;104;111;112;110;111;111;112;110;111;111 19:20:51 INFO - PID 13223 | |1;audio-beat-detection;156;128;123;178;135;126;127;129;152;124 19:20:51 INFO - PID 13223 | |2;audio-dft;162;161;161;164;162;165;164;161;161;165 19:20:51 INFO - PID 13223 | |3;audio-fft;78;75;75;110;76;77;77;76;92;75 19:20:51 INFO - PID 13223 | |4;audio-oscillator;84;83;109;84;84;84;106;84;83;107 19:20:51 INFO - PID 13223 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;114;113;113 19:20:51 INFO - PID 13223 | |6;imaging-darkroom;149;149;149;148;148;149;149;148;148;149 19:20:51 INFO - PID 13223 | |7;imaging-desaturate;94;94;94;95;94;94;94;94;94;93 19:20:51 INFO - PID 13223 | |8;json-parse-financial;66;65;64;64;65;66;71;69;64;68 19:20:51 INFO - PID 13223 | |9;json-stringify-tinderbox;56;61;56;56;55;56;56;55;56;56 19:20:51 INFO - PID 13223 | |10;stanford-crypto-aes;82;90;90;82;83;82;84;81;85;83 19:20:51 INFO - PID 13223 | |11;stanford-crypto-ccm;136;134;134;136;138;131;138;131;220;141 19:20:51 INFO - PID 13223 | |12;stanford-crypto-pbkdf2;185;194;190;192;196;195;193;202;193;187 19:20:51 INFO - PID 13223 | |13;stanford-crypto-sha256-iterative;71;70;71;70;74;72;69;70;69;70 19:20:51 INFO - PID 13223 | __end_tp_report 19:20:51 INFO - PID 13223 | __start_cc_report 19:20:51 INFO - PID 13223 | _x_x_mozilla_cycle_collect,2037 19:20:51 INFO - PID 13223 | __end_cc_report 19:20:51 INFO - PID 13223 | __startTimestamp1490322051803__endTimestamp 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | ------- Summary: start ------- 19:20:51 INFO - PID 13223 | Number of tests: 14 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.31 (2.1%) stddev-sans-first:0.71 19:20:51 INFO - PID 13223 | Values: 104.0 111.0 112.0 110.0 111.0 111.0 112.0 110.0 111.0 111.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:132.00 stddev:18.24 (13.8%) stddev-sans-first:18.12 19:20:51 INFO - PID 13223 | Values: 156.0 128.0 123.0 178.0 135.0 126.0 127.0 129.0 152.0 124.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.71 (1.1%) stddev-sans-first:1.80 19:20:51 INFO - PID 13223 | Values: 162.0 161.0 161.0 164.0 162.0 165.0 164.0 161.0 161.0 165.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:11.36 (14.8%) stddev-sans-first:11.99 19:20:51 INFO - PID 13223 | Values: 78.0 75.0 75.0 110.0 76.0 77.0 77.0 76.0 92.0 75.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:84.00 stddev:11.44 (13.6%) stddev-sans-first:11.86 19:20:51 INFO - PID 13223 | Values: 84.0 83.0 109.0 84.0 84.0 84.0 106.0 84.0 83.0 107.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:20:51 INFO - PID 13223 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 19:20:51 INFO - PID 13223 | Values: 149.0 149.0 149.0 148.0 148.0 149.0 149.0 148.0 148.0 149.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:20:51 INFO - PID 13223 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:2.39 (3.6%) stddev-sans-first:2.54 19:20:51 INFO - PID 13223 | Values: 66.0 65.0 64.0 64.0 65.0 66.0 71.0 69.0 64.0 68.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.80 19:20:51 INFO - PID 13223 | Values: 56.0 61.0 56.0 56.0 55.0 56.0 56.0 55.0 56.0 56.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:3.26 (3.9%) stddev-sans-first:3.36 19:20:51 INFO - PID 13223 | Values: 82.0 90.0 90.0 82.0 83.0 82.0 84.0 81.0 85.0 83.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:137.00 stddev:26.92 (19.7%) stddev-sans-first:28.40 19:20:51 INFO - PID 13223 | Values: 136.0 134.0 134.0 136.0 138.0 131.0 138.0 131.0 220.0 141.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.70 Median:193.50 stddev:4.76 (2.5%) stddev-sans-first:4.16 19:20:51 INFO - PID 13223 | Values: 185.0 194.0 190.0 192.0 196.0 195.0 193.0 202.0 193.0 187.0 19:20:51 INFO - PID 13223 | 19:20:51 INFO - PID 13223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.51 (2.1%) stddev-sans-first:1.59 19:20:51 INFO - PID 13223 | Values: 71.0 70.0 71.0 70.0 74.0 72.0 69.0 70.0 69.0 70.0 19:20:51 INFO - PID 13223 | -------- Summary: end -------- 19:20:51 INFO - PID 13223 | 19:20:52 INFO - TEST-INFO | 13223: exit 0 19:20:53 INFO - TEST-OK | kraken | took 65215ms 19:20:53 INFO - SUITE-END | took 1189s 19:20:53 INFO - Completed test suite (00:19:49) 19:20:53 INFO - javascript benchmark 19:20:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6499.978017585915, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.7204143564927, 2680.128958088622, 2700.378912850044, 2709.7832173426127, 2714.2400127964165, 4983.252512123183, 5054.140796064668, 5140.614453915957, 5152.896942061157, 5192.766325515351, 5080.923786143211, 5112.156494178465, 5140.0490909181735, 5150.356205474316, 5196.038732834429, 4607.285870690049, 4645.349651048856, 4654.301854721785, 4763.54746299101, 4802.0, 4734.360861283734, 4771.594414474774, 4783.569478746912, 4790.97604511977, 4793.185158523042, 4550.840720574797, 4608.9308660370125, 4610.0, 4657.580817726421, 4721.126591580569, 4624.630029597624, 4632.513586073447, 4644.883877903046, 4686.203345431285, 4710.62315014798, 4559.703619264737, 4599.816007359702, 4606.677532572721, 4609.492955774862, 4644.256918892961, 4984.152694042022, 5001.424836143854, 5074.847754567369, 5082.440931497532, 5133.281340612317, 5421.83734487966, 5515.09001014832, 5560.888782224373, 5566.137248726453, 5574.219609254707, 5545.306836645419, 5556.555475561945, 5564.666120032811, 5568.999999999959, 5572.414896435897, 5161.329027226474, 5161.354830646169, 5166.328377311001, 5170.508801663836, 5181.689098654093, 5438.972805135949, 5455.0453670607485, 5502.394736578973, 5504.0, 5507.834764957058, 5332.866678332995, 5334.51989320963, 5338.199270109515, 5339.305890234323, 5348.705821179872, 5382.892342153135, 5524.4199359066715, 5579.776808927598, 5584.776608935678, 5593.216949627055, 5452.40023597404, 5463.043967305705, 5466.289382380265, 5467.289252397242, 5511.669299842022, 5506.697131657717, 5513.145462453326, 5520.641158324696, 5522.2544956431175, 5565.16522521625, 4486.461624605003, 4525.637948964075, 4587.7017993830295, 4628.282616194495, 4638.234691275969, 3944.4083387491532, 3946.9802650987135, 3947.9802600987387, 3974.105826189142, 3988.6809055275507, 4776.895018238173, 4778.068276686083, 4778.689385189951, 4783.425988881357, 4822.276658501182, 5440.0, 5498.230247765316, 5504.779808807602, 5505.504504594525, 5514.779408823682, 4654.488006319302, 4691.225947718656, 4693.319468677023, 4694.765261736899, 4695.577398034125, 4822.156122678587, 4830.227163653799, 4838.540338667821, 4840.515948405131, 4843.2735089736825, 5023.372078490262, 5029.899402012013, 5037.647364684437, 5116.9232461512365, 5123.974380128225, 5514.420985796433, 5528.502434780889, 5528.806491772769, 5528.806491772769, 5534.529564987021, 5099.3370861787735, 5160.896782064413, 5164.586833053271, 5164.612654051037, 5172.844814655567, 5415.810446634349, 5450.454954504677, 5451.836444906659, 5457.154141108134, 5462.562994960473, 5571.804986825442, 5574.665520068809, 5577.3028371453565, 5579.302587176603, 5590.161475778666, 5234.659747116578, 5313.229581710553, 5326.334208223972, 5418.160185171305, 5463.644863083887, 5373.838784836461, 5386.299781028598, 5413.783448662167, 5416.214648875812, 5435.021696094741, 5312.920306195333, 5321.042212401805, 5321.255024296524, 5327.227552005015, 5330.093884039645, 5153.433122356463, 5425.728713564385, 5436.891262174813, 5444.945550544602, 5469.945300547103, 5206.661566998133, 5212.0, 5214.97392513035, 5220.530152286313, 5223.921641175461], "value": 5012.62358524801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.602041581101, 624.8781487609915, 642.2453617000025, 964.185263452383, 968.9970880139058, 23427.882860585694, 30759.69240307599, 31379.901703440413, 31392.372152556934, 31396.37207255859, 33167.66832331676, 33500.66499335006, 33559.66440335596, 33581.49627755586, 33597.49603755945, 5591.3569939456875, 7324.194338622748, 7516.774496765079, 7517.834735615988, 7522.398208143335, 5655.26481557399, 7066.7173313067415, 7285.0, 7296.270372962715, 7298.087739032621, 7377.852442951164, 7425.443091768112, 7427.2201418851055, 7429.294217049399, 7431.516951398169, 5619.353774315924, 7337.156227033906, 7390.963045184793, 7397.075365579302, 7405.777826665155, 5719.456651618131, 7180.964095179543, 7323.890141647827, 7334.413246940232, 7341.52280101797, 30288.394232115454, 30708.0, 30719.078427647208, 30723.0, 30778.53832192519, 2619.0, 2638.103044964702, 2647.3116989582845, 2648.47030593882, 2733.7812974961957, 21436.24973125933, 21609.891950540303, 21746.56506869854, 21776.564468710538, 22101.66847497289, 2558.9616155757494, 2561.654176686161, 2565.2817211180713, 2580.1743442098536, 2748.1206014075506, 118721.99999999914, 118777.40611296975, 118818.40590797077, 119207.0, 119336.0, 37448.62551374506, 37558.62441375606, 40777.796111019255, 40885.0, 41016.179676406304, 42557.44655320629, 42577.148457031304, 42582.78708606499, 42634.360484592755, 42696.57303426988, 12891.806622900664, 13373.398197081155, 13376.0, 13391.531296404579, 13406.329683515785, 8792.47245165292, 8950.14973577509, 10727.249092563447, 10737.51681174349, 10741.946290268499, 12424.56514022023, 12558.560450384193, 12697.111202215941, 12733.0, 12757.617271481871, 4545.795439205243, 4582.9312560310955, 4585.770711464414, 4594.218982772936, 4679.21586655946, 864.9524276164872, 870.8345414371375, 876.1632640827994, 879.0111124984393, 902.9548522573845, 20215.393538193584, 21059.473513162295, 21096.789032109482, 21280.893595531925, 21358.679619805716, 942.641796117471, 943.118184497497, 946.394307643109, 968.7481254873784, 974.9707508774607, 10947.686436635338, 11457.14071444645, 11460.942695286636, 11479.655610331703, 11482.0814334853, 236987.0, 238763.0, 239103.0, 239711.0, 239747.0, 42657.57342426598, 43101.78449107734, 43134.78432607817, 43178.307362358886, 43184.54523638101, 1155.0990227622467, 1199.1366216324407, 1200.3518100225954, 1202.6211743300832, 1214.7631211913592, 19835.702464462756, 19991.20035198634, 20019.699704504153, 20765.60094375443, 20914.477138071063, 29809.403811924072, 38480.0, 39261.0, 39280.410793837545, 39283.0, 254392.82428702645, 256676.0, 256759.0, 256893.0, 257696.0, 22763.0, 23025.309240722807, 30426.0, 30674.539881902234, 30849.537256941614, 25978.0, 31306.530402044442, 31919.0, 32013.67986320107, 32287.838560807046, 25893.223203303933, 26288.211353659422, 26517.07190248332, 26730.866345668925, 27128.864355678095, 25972.35069123287, 26007.349816253987, 26042.73957260479, 26372.0, 27223.04719334814, 29300.267493312836, 29350.266243344086, 29495.0, 29495.85252073726, 29504.557431638113, 25694.357641059123, 25766.355841104123, 25855.0, 26838.194854154408, 27128.050518232558, 20123.597528049064, 21148.894255529238, 21249.150033998467, 21392.893035535344, 21396.251131210334], "value": 14346.16882203757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.09953155166636, 410.9213315047999, 414.3577454944836, 424.3168498717065, 431.66545926906645, 11635.360055196981, 15804.920975395107, 17083.743743843854, 17713.911430442848, 17731.73402398965, 17391.0, 17636.118194090275, 18135.0, 18995.145218465168, 19124.713129303072, 5563.193336966147, 5748.109043098306, 5939.376365481627, 6181.783637572686, 6232.9376706232815, 3611.1513794258326, 6255.59338642989, 6299.464545513637, 6303.968480157616, 6310.0, 3978.8209530571194, 6283.937160628404, 6306.968465157668, 6309.652969086698, 6351.9682401587925, 6054.303755068179, 6140.723667434976, 6228.844278893019, 6283.434490895818, 6300.716467758962, 6075.088736689488, 6080.0, 6176.69116544171, 6181.07283907413, 6187.907181392283, 23373.0, 24134.758652413428, 24473.0, 24601.539846015436, 24697.135600254085, 1589.5628702106897, 1610.6537094524617, 1616.8140663823692, 1658.983410165895, 1660.2279939828038, 14745.262736863222, 14912.776308355384, 15374.308156132889, 15824.0, 16221.756673649905, 1727.2054854766823, 1771.4597047900386, 1781.6436712657392, 1817.500187448449, 1818.9090545472807, 69263.65368173177, 77860.0, 86243.56878215632, 87154.0, 89430.552847236, 17350.0, 17497.30010799554, 17587.208575614128, 17786.5553361167, 18026.188821503063, 25527.0, 32525.837370813468, 32614.67385326164, 32632.0, 32878.0, 8591.871121933176, 8660.39377243587, 8797.824043519095, 9183.724488265363, 9433.716988490356, 7020.824479387954, 7121.252268511836, 7137.643117844087, 7307.415406767446, 7365.594892280868, 9305.627774888928, 9390.85913711295, 9431.952840235756, 9433.669821556212, 9458.52707364629, 3475.7740746851373, 3549.432090865449, 3749.737518373742, 3871.922561548753, 3969.3053715599654, 805.8952336196375, 845.7716416567492, 847.7287268074157, 854.7350321400386, 859.1151114352227, 16590.419335323448, 17487.475375738493, 17732.556686082695, 17791.377301794375, 18554.350597729015, 857.2199298638209, 863.8533244886452, 865.6926790989235, 872.9519876406858, 883.8099808541066, 8834.95582522096, 9658.323917325719, 9687.370320929118, 9726.854097188549, 9755.317127801127, 503331.0, 504391.0, 506406.0, 507183.13802343217, 515752.0, 86423.0, 87747.12252877517, 88307.0, 89635.55182224046, 93414.06585934054, 1099.6206308823444, 1100.8568886044923, 1109.916756243285, 1114.025227925565, 1115.8772535021142, 14913.3289001993, 14972.326245318769, 15000.174990375634, 15186.24068796578, 15486.225688715294, 26857.452423671242, 40692.1861562773, 41453.58546414497, 42473.36289955591, 42652.86735663266, 50475.466717330906, 50591.0, 50783.0, 51023.48976510188, 53756.46243537671, 7700.383969282556, 7712.0, 7758.107817600822, 7783.649735762017, 7941.324987376138, 11116.610918618133, 11139.83290250663, 11161.772205057276, 11246.887531124585, 11522.42387880586, 10033.498325083863, 10202.540885660312, 10214.69355919294, 10373.481325933522, 10452.634157804441, 8535.786605334917, 9238.399504032217, 9739.415635061636, 9768.267379946674, 9981.401115933068, 9308.627654893728, 9646.951765241129, 9832.16426603718, 9968.102870741668, 10316.638917637847, 7532.962335188289, 7991.800204994922, 8023.916771236042, 8211.096779354148, 8224.753257402288, 10518.947405262925, 10717.410542420243, 10752.354858708502, 10978.780424391627, 11231.775364492827], "value": 9463.345999540139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.7546490701861, 1269.4351013798857, 1282.3075539208828, 1288.1884412819923, 1294.8057791331296, 9263.722088337343, 9613.951930240357, 9626.085521875428, 9644.710658680233, 9649.372790768595, 9603.375780574257, 9894.554745036472, 9942.751431214223, 9954.601815927354, 9963.950180249089, 2122.586095711337, 2155.2241193170526, 2158.6006588781124, 2158.881261530615, 2159.3953692965993, 1818.9818101818944, 2070.109852763311, 2116.2064225915283, 2122.660374340106, 2174.891255437222, 1871.101871101872, 2085.947851303722, 2157.46063484129, 2158.7841215878443, 2168.2519530761942, 2054.9280775172947, 2079.085202510898, 2079.6672532394896, 2085.582883423306, 2086.301089135149, 2036.867603605761, 2040.7245021922, 2042.9795702042939, 2044.1618936236073, 2049.1496029147884, 9535.141837234612, 9638.71083867478, 9657.420554766737, 9663.951680241624, 9671.226301895831, 4950.381202349707, 5226.242194881721, 5226.92159617606, 5236.842894713165, 5239.187925871458, 2974.762019038472, 3041.148478426044, 3285.704286614216, 3295.571575695168, 3295.7692961492703, 997.5610731278286, 997.7156510394502, 998.3211416236956, 1042.6142327338857, 1056.5245639462273, 13715.862841371558, 14177.645558861112, 14354.425822967174, 14538.70922581553, 14555.490557830424, 4670.6497012724185, 4783.425988881357, 4790.377250957423, 4827.61379089672, 4836.758162091952, 10765.3540787553, 10769.515371808287, 10774.084202842847, 11145.0, 11167.72080697989, 5253.448387919213, 5257.921131183035, 5265.657732247391, 5268.130758424893, 5270.8945821084135, 4669.252919532859, 4726.763661816895, 4799.472058073609, 4799.832005879847, 4802.183628783116, 3538.6284440133413, 3687.5574931007914, 3698.7410881238593, 3750.1187221003042, 3761.3041587306434, 962.1965658675085, 1091.0725882999545, 1098.609993452313, 1114.554178328675, 1115.4813011949482, 583.76941108262, 656.5765081522392, 685.9657017149123, 694.9687264073128, 735.0884902720695, 4883.4628190898975, 5213.478652134832, 5219.791208351699, 5222.817201397933, 5388.9730551347775, 812.5327936436572, 823.7322870067132, 831.846108469935, 833.8123922117596, 851.7402192331275, 3612.6206748291575, 3665.9266814664093, 3724.832382542792, 3744.7753134811996, 3835.7314987951136, 12416.627501174979, 12997.935010324887, 13009.284489352987, 13010.21938683682, 13014.479420823061, 12915.677108072374, 12918.935405322913, 12921.418536165895, 12928.0, 12936.870631293756, 8899.688510902217, 9275.397099188665, 9279.72160835176, 9282.860757088649, 9298.209652179505, 5958.523318134452, 6014.9097763534455, 6103.9285179454255, 6105.755769769159, 6336.714847831767, 11530.884691152982, 11779.823302650295, 11837.691650128143, 11843.348615826213, 12134.393280336124, 11650.592229272273, 12047.939760301142, 12166.209196402206, 12169.20900141488, 12191.207571507824, 8069.3544516439715, 8331.125231850569, 8348.165183481604, 8348.499090054373, 8355.080941096354, 9263.814723705624, 9297.72106836796, 9418.95290523543, 9493.098155675476, 9540.379875308083, 7877.6455059523605, 7944.245296696805, 7987.241212084843, 8015.078265999251, 8160.673573057011, 7212.675429605575, 7236.078166714661, 7242.637868106679, 7370.742024029133, 7468.7759367216895, 6832.248452670103, 6839.281875403011, 6842.623655698785, 6896.517243792886, 6901.482388820758, 4611.907761844677, 4627.398438203012, 4918.409790825124, 5074.238864170404, 5086.338775959101, 4854.75726213695, 4962.528559786814, 5000.899982000266, 5048.495150485069, 5125.820596279113], "value": 4579.688330421186, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5877899194918, 380.8305304139659, 388.68516501633695, 391.9921601567969, 394.9328614135597, 5313.176457649066, 5365.168398898168, 5369.301990741203, 5386.703731294782, 5409.6213265071465, 5241.6191556446065, 5299.231611416342, 5311.1502159654465, 5319.654222475537, 5324.949894290697, 4030.234255491447, 4062.370332598452, 4085.7957102144924, 4245.7240279381895, 4296.935545966813, 4106.691998100139, 4120.876373708778, 4123.649489793356, 4123.97938010311, 4127.566605506424, 4091.8158682859344, 4096.528899176588, 4097.569755175708, 4097.856575019875, 4117.938230926538, 3857.167845273501, 4087.713860029799, 4095.0786073133604, 4108.897277568055, 4120.62914337708, 3539.52216450781, 3579.0873327301633, 3585.713142948558, 3595.1012246938267, 3607.134287770942, 5159.69041857486, 5182.870428239286, 5187.507186817246, 5189.974050129763, 5211.530962213381, 4705.106029854351, 4729.266963620645, 4733.834315798965, 4736.786844592001, 4744.16977029022, 5432.402435732066, 5608.4391560844, 5640.351359593658, 5646.124850648156, 5648.068068768689, 3974.5429275633383, 3979.1047014421815, 3983.820728067244, 3991.980040099781, 3996.8800935971967, 5652.428145193927, 5678.801241956512, 5798.42015798421, 5869.8239052828485, 5977.701114944235, 4025.6376926076796, 4041.191761647682, 4049.817758200888, 4052.169305292408, 4057.0871553900724, 4071.75569465833, 4115.32097203964, 4119.258533463945, 4124.092699606142, 4139.97930010348, 4385.6710746694125, 4474.0, 4505.5719706627815, 4739.549742774431, 4746.0, 5473.589480788957, 5516.117421212587, 5526.336839579276, 5609.523190528769, 5640.746166422521, 1399.971021299344, 1416.8795652369663, 1422.345720968366, 1423.4306277489088, 1428.9356978935973, 908.2779190543533, 948.3977674176947, 956.7368973532334, 962.6390103711109, 968.1045033344128, 4928.186849169919, 4928.704277743347, 4929.852104436873, 4933.087378834927, 4948.802047918115, 5764.510016648548, 5800.187973683687, 5804.158397032406, 5812.796552120655, 5820.330661973842, 4834.694632449289, 4899.4365647950945, 4935.679180853233, 4960.817240414206, 4966.8758281043265, 3054.1906394805396, 3086.4135814195233, 3087.5368694695526, 3096.969030309713, 3101.3022070034062, 5397.703126328011, 5401.648892821954, 5402.540784033323, 5406.378266499403, 5427.240186373911, 5811.88376232473, 5937.70311484424, 5948.196993405922, 5954.910676339859, 5958.821235362946, 5372.5701943843615, 5375.919361209585, 5388.9730551347775, 5399.0, 5402.459754024566, 5560.221568980265, 5794.565407594531, 5800.4489573490455, 5811.86668599619, 5836.0, 5696.886062278814, 5730.598858079894, 5738.626989245853, 5757.8560535986935, 5760.790234050896, 5126.384833819965, 5225.372955245395, 5312.946870531246, 5348.545373643284, 5406.972965135149, 4025.2150830587752, 4041.8787436376956, 4042.3532234842282, 4043.6765058795813, 4050.8784736457956, 5771.163181338598, 5773.393793651606, 5789.739461724148, 5798.56510761703, 5824.835032993334, 5420.241166236651, 5579.637323573955, 5603.943960560342, 5613.382527922007, 5625.831225063254, 5588.357338905916, 5594.188842617717, 5604.8318550443555, 5620.241267428844, 5635.154726791015, 5389.865253368697, 5526.585506086979, 5530.7511161997, 5545.639533430314, 5573.554115670656, 5609.971950140223, 5627.184058311604, 5641.858953526031, 5646.8706258749235, 5667.263255776723, 5484.8354549363585, 5500.697461639648, 5501.229827824188, 5522.0, 5523.696196709219], "value": 4221.315578744369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.6963057732288, 647.1877793369321, 661.2329697550842, 676.3675962974617, 679.3410391919836, 10795.56817727291, 11352.545898164073, 11372.147088968319, 11382.544698212072, 11383.772324553503, 11156.274842135255, 11335.149863760209, 11509.30944143352, 11685.182037257395, 11877.703057423569, 809.8015986083418, 821.289584509401, 822.62159406673, 822.7408366364606, 826.1366871619173, 795.6499140378215, 817.1175130858688, 819.2544784246337, 819.4264015189361, 828.349745449822, 856.8072183758636, 863.2791618998144, 863.8401895649325, 865.1867244789909, 865.6364326982682, 855.6791203298762, 856.2892798976897, 856.5075081827974, 856.9314454843598, 857.6998050682242, 632.0771673356904, 633.4520639646672, 633.4583930739244, 633.6324931539696, 633.8130251575797, 13051.086423950328, 13404.262765547892, 13446.79829802544, 13453.932730336286, 13592.11651242666, 13367.665808354772, 13979.79030314546, 14136.182794098631, 14204.57386278403, 14369.209693466959, 9017.7821721179, 9383.812323753487, 9742.366746161548, 9778.804423911482, 9921.85117223235, 2506.5362907862104, 2512.133314006665, 2535.6703628528358, 2551.4641925195733, 2580.36780988659, 63474.0, 63641.681791590745, 64444.67777661129, 65039.67480162616, 65930.67034664843, 10337.586496540205, 10655.094316982988, 10710.839337409945, 10732.678019659423, 10966.451677416097, 19451.416457506297, 19659.803401966084, 19680.803191967898, 19698.0, 19836.10737516815, 6504.739810407531, 6534.673266336664, 6541.215054193527, 6561.5734977227285, 6774.288699686561, 3343.5653365062385, 3381.1040074380307, 3391.6099648540735, 3438.3123375325035, 3457.083872773717, 3204.3110731192437, 3235.563198968156, 3247.8863239786965, 3267.39553182662, 3287.3260981498734, 623.5323507369473, 624.3912185619076, 631.8167731357946, 640.1741753138399, 647.9740810367626, 520.60608464559, 541.5667466027163, 549.1159233633846, 549.5219159331327, 551.5615086006634, 7989.880151797728, 8085.0, 8116.443320354069, 8175.305099066646, 8182.590870456573, 462.70155749541357, 481.30691803802415, 486.7858142417325, 488.9193283108247, 492.55423841423567, 3604.279144171176, 3614.945775813365, 3621.257642183346, 3703.6851867591017, 3726.7950262735267, 56211.43788562144, 56414.0, 56988.43011569914, 57341.713291433276, 57881.0, 51009.0, 51485.227721584204, 51857.2221416679, 52179.73910130425, 53359.46640533623, 47856.5214347859, 47860.760696196296, 48371.5162848367, 48760.51239487559, 48889.511104888494, 7231.819204519929, 7278.454115941219, 7317.597532135784, 7404.0, 7642.312191902755, 25212.873935630203, 25566.61650075213, 25993.22020339393, 26187.738122619292, 26716.465670686866, 30187.547186791777, 30200.5469917947, 30236.84881575578, 30393.696063039086, 30450.238744030692, 9359.532023398939, 9367.906320936703, 9427.15155635996, 9518.762030949281, 9597.23222142213, 9704.70885873425, 9720.160536587866, 9929.950350248202, 10019.448930308612, 10119.949400252952, 8933.731988040368, 8937.553122343987, 9100.271978241857, 9103.135202155785, 9454.905450945678, 9426.905730942603, 9904.158146557624, 10023.949880250844, 10203.03071208234, 10299.124574411258, 8972.81956118309, 9392.248620110511, 9415.340926135104, 9502.097300756417, 9665.0, 6348.111264423077, 6448.838779030374, 6589.110470086477, 6652.600843949379, 6785.389314961677, 7269.55394320202, 7501.549907005598, 7677.500962437423, 7773.883391749016, 8147.063087744985], "value": 5732.00353716063, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 110.0, 111.0, 111.0, 112.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 123.0, 178.0, 135.0, 126.0, 127.0, 129.0, 152.0, 124.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 164.0, 162.0, 165.0, 164.0, 161.0, 161.0, 165.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 110.0, 76.0, 77.0, 77.0, 76.0, 92.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 109.0, 84.0, 84.0, 84.0, 106.0, 84.0, 83.0, 107.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 65.0, 66.0, 71.0, 69.0, 64.0, 68.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 90.0, 90.0, 82.0, 83.0, 82.0, 84.0, 81.0, 85.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 134.0, 136.0, 138.0, 131.0, 138.0, 131.0, 220.0, 141.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 194.0, 190.0, 192.0, 196.0, 195.0, 193.0, 202.0, 193.0, 187.0], "value": 192.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 70.0, 74.0, 72.0, 69.0, 70.0, 69.0, 70.0], "value": 70.6, "unit": "score"}]}]} 19:20:53 INFO - Return code: 0 19:20:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:53 ERROR - # TBPL SUCCESS # 19:20:53 INFO - Running post-action listener: _resource_record_post_action 19:20:53 INFO - [mozharness: 2017-03-24 02:20:53.617089Z] Finished run-tests step (success) 19:20:53 INFO - Running post-run listener: _resource_record_post_run 19:20:53 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 362307584; Read time: 8; Write time: 206348 19:20:53 INFO - TinderboxPrint: CPU usage
13.0% 19:20:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:20:53 INFO - TinderboxPrint: I/O write bytes / time
362,307,584 / 206,348 19:20:53 INFO - TinderboxPrint: CPU idle
8,377.9 (87.0%) 19:20:53 INFO - TinderboxPrint: CPU user
1,200.0 (12.5%) 19:20:53 INFO - TinderboxPrint: Swap in / out
0 / 0 19:20:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106463232; Read time: 0; Write time: 92712 19:20:53 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255455232; Read time: 8; Write time: 113604 19:20:54 INFO - Running post-run listener: _upload_blobber_files 19:20:54 INFO - Blob upload gear active. 19:20:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:54 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 19:20:54 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:54 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:20:54 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:20:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:20:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:55 INFO - (blobuploader) - INFO - Done attempting. 19:20:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:20:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:56 INFO - (blobuploader) - INFO - Done attempting. 19:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:59 INFO - (blobuploader) - INFO - Done attempting. 19:20:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:20:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:00 INFO - (blobuploader) - INFO - Done attempting. 19:21:00 INFO - (blobuploader) - INFO - Iteration through files over. 19:21:00 INFO - Return code: 0 19:21:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:21:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:21:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/d8925feb92703660173561f6f9e3af1e6b7ab8f99cedc8b1976a4975761521664188a1f96a6ed16b89e3630b50bdfccc0a9cfaa37ea6701b4cc58f8482d2e256", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3a0453d5c214407afa02c6751f36ded250ca98e35e2e6e0acdf52242b76875c17d4afd786e7ea71f7a6c5b08e3780cb286d73dd24a4f1155f3802136255b8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/973e2eb51777ac5c6f3600b559a862228292ded84728d414cd138c1f65d1b1fa493f227dc61d4e9e1071800aeb5f1a06bb56b3a111e01eb0ed942d93be618537", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2f22b0c899bb9f429dcbf1d882b4827d3cb04ddb35b2ac8150b2ab507218c32beedb39a280a0e05bd1953a223daf3b6db17d4961975fd262e49a37a34eee323"} 19:21:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:21:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:21:00 INFO - Contents: 19:21:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/d8925feb92703660173561f6f9e3af1e6b7ab8f99cedc8b1976a4975761521664188a1f96a6ed16b89e3630b50bdfccc0a9cfaa37ea6701b4cc58f8482d2e256", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3a0453d5c214407afa02c6751f36ded250ca98e35e2e6e0acdf52242b76875c17d4afd786e7ea71f7a6c5b08e3780cb286d73dd24a4f1155f3802136255b8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/973e2eb51777ac5c6f3600b559a862228292ded84728d414cd138c1f65d1b1fa493f227dc61d4e9e1071800aeb5f1a06bb56b3a111e01eb0ed942d93be618537", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2f22b0c899bb9f429dcbf1d882b4827d3cb04ddb35b2ac8150b2ab507218c32beedb39a280a0e05bd1953a223daf3b6db17d4961975fd262e49a37a34eee323"} 19:21:00 INFO - Running post-run listener: copy_logs_to_upload_dir 19:21:00 INFO - Copying logs to upload dir... 19:21:00 INFO - mkdir: /builds/slave/test/build/upload/logs 19:21:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.392251 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-03-23 19:20:59.393334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:20:59.396630) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/d8925feb92703660173561f6f9e3af1e6b7ab8f99cedc8b1976a4975761521664188a1f96a6ed16b89e3630b50bdfccc0a9cfaa37ea6701b4cc58f8482d2e256", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3a0453d5c214407afa02c6751f36ded250ca98e35e2e6e0acdf52242b76875c17d4afd786e7ea71f7a6c5b08e3780cb286d73dd24a4f1155f3802136255b8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/973e2eb51777ac5c6f3600b559a862228292ded84728d414cd138c1f65d1b1fa493f227dc61d4e9e1071800aeb5f1a06bb56b3a111e01eb0ed942d93be618537", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2f22b0c899bb9f429dcbf1d882b4827d3cb04ddb35b2ac8150b2ab507218c32beedb39a280a0e05bd1953a223daf3b6db17d4961975fd262e49a37a34eee323"} build_url:https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/BB5OsR0cSquSGZobh5SR5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/d8925feb92703660173561f6f9e3af1e6b7ab8f99cedc8b1976a4975761521664188a1f96a6ed16b89e3630b50bdfccc0a9cfaa37ea6701b4cc58f8482d2e256", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3a0453d5c214407afa02c6751f36ded250ca98e35e2e6e0acdf52242b76875c17d4afd786e7ea71f7a6c5b08e3780cb286d73dd24a4f1155f3802136255b8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/973e2eb51777ac5c6f3600b559a862228292ded84728d414cd138c1f65d1b1fa493f227dc61d4e9e1071800aeb5f1a06bb56b3a111e01eb0ed942d93be618537", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2f22b0c899bb9f429dcbf1d882b4827d3cb04ddb35b2ac8150b2ab507218c32beedb39a280a0e05bd1953a223daf3b6db17d4961975fd262e49a37a34eee323"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:20:59.423997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:20:59.424826) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490320791.227017-1651584206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004387 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:20:59.503698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:20:59.503970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:20:59.504245) ========= ========= Total master_lag: 0.14 =========