builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1495764135.39 results: success (0) revision: c2ff59dd31bce41bc9108939e86618017943b88d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.394867) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.395410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.395690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.411848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.412136) ========= 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=836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 19:02:15-- 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% 29.6M=0s 2017-05-25 19:02:16 (29.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.603217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.603556) ========= 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=836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.653145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:15.656506) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2ff59dd31bce41bc9108939e86618017943b88d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c2ff59dd31bce41bc9108939e86618017943b88d --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=836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 19:02:16,210 truncating revision to first 12 chars 2017-05-25 19:02:16,211 Setting DEBUG logging. 2017-05-25 19:02:16,211 attempt 1/10 2017-05-25 19:02:16,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2ff59dd31bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 19:02:16,803 unpacking tar archive at: mozilla-central-c2ff59dd31bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.961125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:16.630029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:16.633377) ========= script_repo_revision: c2ff59dd31bce41bc9108939e86618017943b88d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:16.633768) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:16.634048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:02:16.642622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-05-25 19:02:16.642917) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:02:17 INFO - MultiFileLogger online at 20170525 19:02:17 in /builds/slave/test 19:02:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:02:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:02:17 INFO - {'append_to_log': False, 19:02:17 INFO - 'base_work_dir': '/builds/slave/test', 19:02:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:02:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:02:17 INFO - 'branch': 'Firefox-Non-PGO', 19:02:17 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:17 INFO - 'config_files': ('talos/linux_config.py',), 19:02:17 INFO - 'default_actions': ('clobber', 19:02:17 INFO - 'read-buildbot-config', 19:02:17 INFO - 'download-and-extract', 19:02:17 INFO - 'populate-webroot', 19:02:17 INFO - 'create-virtualenv', 19:02:17 INFO - 'install', 19:02:17 INFO - 'run-tests'), 19:02:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:17 INFO - 'download_minidump_stackwalk': True, 19:02:17 INFO - 'download_symbols': 'ondemand', 19:02:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:17 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:17 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:17 INFO - 'gecko_profile': False, 19:02:17 INFO - 'gecko_profile_interval': 0, 19:02:17 INFO - 'installer_path': 'installer.exe', 19:02:17 INFO - 'log_level': 'info', 19:02:17 INFO - 'log_name': 'talos', 19:02:17 INFO - 'log_to_console': True, 19:02:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:02:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:02:17 INFO - 'opt_config_files': (), 19:02:17 INFO - 'pip_index': False, 19:02:17 INFO - 'suite': 'dromaeojs-e10s', 19:02:17 INFO - 'system_bits': '32', 19:02:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:17 INFO - 'title': 'talos-linux64-ix-028', 19:02:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:17 INFO - 'use_talos_json': True, 19:02:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:02:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:17 INFO - 'work_dir': 'build'} 19:02:17 INFO - [mozharness: 2017-05-26 02:02:17.296911Z] Running clobber step. 19:02:17 INFO - Running pre-action listener: _resource_record_pre_action 19:02:17 INFO - Running main action method: clobber 19:02:17 INFO - rmtree: /builds/slave/test/build 19:02:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:02:18 INFO - Running post-action listener: _resource_record_post_action 19:02:18 INFO - [mozharness: 2017-05-26 02:02:18.322500Z] Finished clobber step (success) 19:02:18 INFO - [mozharness: 2017-05-26 02:02:18.322600Z] Running read-buildbot-config step. 19:02:18 INFO - Running pre-action listener: _resource_record_pre_action 19:02:18 INFO - Running main action method: read_buildbot_config 19:02:18 INFO - Using buildbot properties: 19:02:18 INFO - { 19:02:18 INFO - "project": "", 19:02:18 INFO - "product": "firefox", 19:02:18 INFO - "who": "ryanvm@gmail.com", 19:02:18 INFO - "installer_path": "public/build/target.tar.bz2", 19:02:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:02:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:02:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:02:18 INFO - "stage_platform": "linux64", 19:02:18 INFO - "basedir": "/builds/slave/test", 19:02:18 INFO - "buildnumber": 635, 19:02:18 INFO - "platform": "ubuntu64_hw", 19:02:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:02:18 INFO - "slavebuilddir": "test", 19:02:18 INFO - "taskId": "PXsyYuzHTgymoGBMXE4GTg", 19:02:18 INFO - "branch": "mozilla-central", 19:02:18 INFO - "script_repo_revision": "production", 19:02:18 INFO - "revision": "c2ff59dd31bce41bc9108939e86618017943b88d", 19:02:18 INFO - "slavename": "talos-linux64-ix-028", 19:02:18 INFO - "repo_path": "mozilla-central" 19:02:18 INFO - } 19:02:18 INFO - Finding installer, test and symbols from parent task. 19:02:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXsyYuzHTgymoGBMXE4GTg'}, attempt #1 19:02:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXsyYuzHTgymoGBMXE4GTg'}, attempt #1 19:02:19 INFO - Task dependencies: Iu6WqRooSzam46W6nL4ZbQ 19:02:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ'}, attempt #1 19:02:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2 19:02:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/test_packages.json 19:02:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.crashreporter-symbols.zip 19:02:19 INFO - Running post-action listener: _resource_record_post_action 19:02:19 INFO - [mozharness: 2017-05-26 02:02:19.673901Z] Finished read-buildbot-config step (success) 19:02:19 INFO - [mozharness: 2017-05-26 02:02:19.674122Z] Running download-and-extract step. 19:02:19 INFO - Running pre-action listener: _resource_record_pre_action 19:02:19 INFO - Running main action method: download_and_extract 19:02:19 INFO - mkdir: /builds/slave/test/build/tests 19:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:19 INFO - trying https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.test_packages.json 19:02:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:02:20 INFO - Downloaded 986 bytes. 19:02:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:02:20 INFO - Using the following test package requirements: 19:02:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:02:20 INFO - u'common': [u'target.common.tests.zip'], 19:02:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:02:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:02:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:02:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:02:20 INFO - u'mozbase': [u'target.common.tests.zip'], 19:02:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:02:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:02:20 INFO - u'web-platform': [u'target.common.tests.zip', 19:02:20 INFO - u'target.web-platform.tests.zip'], 19:02:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:02:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:02:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.common.tests.zip 19:02:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:02:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.common.tests.zip into memory 19:02:21 INFO - Content-Length response header: 63532447 19:02:21 INFO - Bytes received: 63532447 19:02:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:02:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.common.tests.zip 19:02:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:02:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.common.tests.zip into memory 19:02:33 INFO - Content-Length response header: 63532447 19:02:33 INFO - Bytes received: 63532447 19:02:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.talos.tests.zip 19:02:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:02:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.talos.tests.zip into memory 19:02:46 INFO - Content-Length response header: 14411888 19:02:46 INFO - Bytes received: 14411888 19:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:46 INFO - trying https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2 19:02:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:02:47 INFO - Downloaded 53989364 bytes. 19:02:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2 19:02:47 INFO - mkdir: /builds/slave/test/properties 19:02:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:02:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:02:47 INFO - Contents: 19:02:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2 19:02:47 INFO - Running post-action listener: _resource_record_post_action 19:02:47 INFO - Running post-action listener: set_extra_try_arguments 19:02:47 INFO - [mozharness: 2017-05-26 02:02:47.512728Z] Finished download-and-extract step (success) 19:02:47 INFO - [mozharness: 2017-05-26 02:02:47.512825Z] Running populate-webroot step. 19:02:47 INFO - Running pre-action listener: _resource_record_pre_action 19:02:47 INFO - Running main action method: populate_webroot 19:02:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:02:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:02:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:02:47 INFO - '--tppagecycles', 19:02:47 INFO - '7'], 19:02:47 INFO - 'tests': ['tsvgm']}}, 19:02:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:02:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:02:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:02:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:02:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['damp', 'tps']}, 19:02:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'tests': ['damp', 'tps']}, 19:02:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['dromaeo_dom']}, 19:02:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:02:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:02:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:02:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:02:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['a11yr', 19:02:47 INFO - 'ts_paint', 19:02:47 INFO - 'tpaint', 19:02:47 INFO - 'sessionrestore', 19:02:47 INFO - 'sessionrestore_no_auto_restore', 19:02:47 INFO - 'tabpaint']}, 19:02:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:02:47 INFO - 'ts_paint', 19:02:47 INFO - 'tpaint', 19:02:47 INFO - 'sessionrestore', 19:02:47 INFO - 'sessionrestore_no_auto_restore', 19:02:47 INFO - 'tabpaint']}, 19:02:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:02:47 INFO - 'ts_paint', 19:02:47 INFO - 'tpaint', 19:02:47 INFO - 'sessionrestore', 19:02:47 INFO - 'sessionrestore_no_auto_restore', 19:02:47 INFO - 'tabpaint']}, 19:02:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:02:47 INFO - 'ts_paint', 19:02:47 INFO - 'tpaint', 19:02:47 INFO - 'sessionrestore', 19:02:47 INFO - 'sessionrestore_no_auto_restore', 19:02:47 INFO - 'tabpaint']}, 19:02:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['a11yr', 19:02:47 INFO - 'ts_paint', 19:02:47 INFO - 'tpaint', 19:02:47 INFO - 'sessionrestore', 19:02:47 INFO - 'sessionrestore_no_auto_restore', 19:02:47 INFO - 'tabpaint']}, 19:02:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['a11yr', 19:02:47 INFO - 'ts_paint', 19:02:47 INFO - 'tpaint', 19:02:47 INFO - 'sessionrestore', 19:02:47 INFO - 'sessionrestore_no_auto_restore', 19:02:47 INFO - 'tabpaint']}, 19:02:47 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:02:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:02:47 INFO - 'bloom_basic_ref']}, 19:02:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['tsvgx', 19:02:47 INFO - 'tsvgr_opacity', 19:02:47 INFO - 'tart', 19:02:47 INFO - 'tscrollx', 19:02:47 INFO - 'cart', 19:02:47 INFO - 'tsvg_static']}, 19:02:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:02:47 INFO - 'tsvgr_opacity', 19:02:47 INFO - 'tart', 19:02:47 INFO - 'tscrollx', 19:02:47 INFO - 'cart', 19:02:47 INFO - 'tsvg_static']}, 19:02:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'talos_options': ['--disable-e10s'], 19:02:47 INFO - 'tests': ['tp5o']}, 19:02:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:02:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'talos_options': ['--disable-e10s', 19:02:47 INFO - '--xperf_path', 19:02:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:47 INFO - 'tests': ['tp5n']}, 19:02:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:02:47 INFO - 'talos_options': ['--xperf_path', 19:02:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:47 INFO - 'tests': ['tp5n']}}, 19:02:47 INFO - 'talos.zip': {'path': '', 19:02:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:02:47 INFO - Running post-action listener: _resource_record_post_action 19:02:47 INFO - [mozharness: 2017-05-26 02:02:47.526762Z] Finished populate-webroot step (success) 19:02:47 INFO - [mozharness: 2017-05-26 02:02:47.526851Z] Running create-virtualenv step. 19:02:47 INFO - Running pre-action listener: _resource_record_pre_action 19:02:47 INFO - Running main action method: create_virtualenv 19:02:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:02:47 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:02:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:02:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:02:47 INFO - Using real prefix '/usr' 19:02:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:02:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:02:50 INFO - Installing pip.................done. 19:02:50 INFO - Return code: 0 19:02:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:02:50 INFO - Reading from file tmpfile_stdout 19:02:50 INFO - Output received: 19:02:50 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:02:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:02:50 INFO - Using env: {'DISPLAY': ':0', 19:02:50 INFO - 'HOME': '/home/cltbld', 19:02:50 INFO - 'LANG': 'en_US.UTF-8', 19:02:50 INFO - 'LANGUAGE': 'en_US:en', 19:02:50 INFO - 'LOGNAME': 'cltbld', 19:02:50 INFO - 'MAIL': '/var/mail/cltbld', 19:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:50 INFO - 'MOZ_NO_REMOTE': '1', 19:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:50 INFO - 'NO_EM_RESTART': '1', 19:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:50 INFO - 'PWD': '/builds/slave/test', 19:02:50 INFO - 'SHELL': '/bin/bash', 19:02:50 INFO - 'SHLVL': '1', 19:02:50 INFO - 'TERM': 'linux', 19:02:50 INFO - 'TMOUT': '86400', 19:02:50 INFO - 'USER': 'cltbld', 19:02:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:50 INFO - '_': '/tools/buildbot/bin/python'} 19:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:50 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:02:50 INFO - Cleaning up... 19:02:50 INFO - Return code: 0 19:02:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:02:50 INFO - Using env: {'DISPLAY': ':0', 19:02:50 INFO - 'HOME': '/home/cltbld', 19:02:50 INFO - 'LANG': 'en_US.UTF-8', 19:02:50 INFO - 'LANGUAGE': 'en_US:en', 19:02:50 INFO - 'LOGNAME': 'cltbld', 19:02:50 INFO - 'MAIL': '/var/mail/cltbld', 19:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:50 INFO - 'MOZ_NO_REMOTE': '1', 19:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:50 INFO - 'NO_EM_RESTART': '1', 19:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:50 INFO - 'PWD': '/builds/slave/test', 19:02:50 INFO - 'SHELL': '/bin/bash', 19:02:50 INFO - 'SHLVL': '1', 19:02:50 INFO - 'TERM': 'linux', 19:02:50 INFO - 'TMOUT': '86400', 19:02:50 INFO - 'USER': 'cltbld', 19:02:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:50 INFO - '_': '/tools/buildbot/bin/python'} 19:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:50 INFO - Downloading/unpacking psutil>=3.1.1 19:02:50 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:02:50 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:02:50 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:02:50 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:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:51 INFO - Installing collected packages: psutil 19:02:51 INFO - Running setup.py install for psutil 19:02:52 INFO - building 'psutil._psutil_linux' extension 19:02:52 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:02:52 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:02:52 INFO - building 'psutil._psutil_posix' extension 19:02:52 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:02:52 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:02:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:52 INFO - Successfully installed psutil 19:02:52 INFO - Cleaning up... 19:02:52 INFO - Return code: 0 19:02:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:52 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/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:02:52 INFO - Using env: {'DISPLAY': ':0', 19:02:52 INFO - 'HOME': '/home/cltbld', 19:02:52 INFO - 'LANG': 'en_US.UTF-8', 19:02:52 INFO - 'LANGUAGE': 'en_US:en', 19:02:52 INFO - 'LOGNAME': 'cltbld', 19:02:52 INFO - 'MAIL': '/var/mail/cltbld', 19:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:52 INFO - 'MOZ_NO_REMOTE': '1', 19:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:52 INFO - 'NO_EM_RESTART': '1', 19:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:52 INFO - 'PWD': '/builds/slave/test', 19:02:52 INFO - 'SHELL': '/bin/bash', 19:02:52 INFO - 'SHLVL': '1', 19:02:52 INFO - 'TERM': 'linux', 19:02:52 INFO - 'TMOUT': '86400', 19:02:52 INFO - 'USER': 'cltbld', 19:02:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:52 INFO - '_': '/tools/buildbot/bin/python'} 19:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:02:52 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:02:52 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:02:52 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:02:52 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:02:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:02:53 INFO - Installing collected packages: mozsystemmonitor 19:02:53 INFO - Running setup.py install for mozsystemmonitor 19:02:53 INFO - Successfully installed mozsystemmonitor 19:02:53 INFO - Cleaning up... 19:02:53 INFO - Return code: 0 19:02:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:02:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:02:53 INFO - Using env: {'DISPLAY': ':0', 19:02:53 INFO - 'HOME': '/home/cltbld', 19:02:53 INFO - 'LANG': 'en_US.UTF-8', 19:02:53 INFO - 'LANGUAGE': 'en_US:en', 19:02:53 INFO - 'LOGNAME': 'cltbld', 19:02:53 INFO - 'MAIL': '/var/mail/cltbld', 19:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:53 INFO - 'MOZ_NO_REMOTE': '1', 19:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:53 INFO - 'NO_EM_RESTART': '1', 19:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:53 INFO - 'PWD': '/builds/slave/test', 19:02:53 INFO - 'SHELL': '/bin/bash', 19:02:53 INFO - 'SHLVL': '1', 19:02:53 INFO - 'TERM': 'linux', 19:02:53 INFO - 'TMOUT': '86400', 19:02:53 INFO - 'USER': 'cltbld', 19:02:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:53 INFO - '_': '/tools/buildbot/bin/python'} 19:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:55 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:55 INFO - warning: no files found matching '*.txt' 19:02:55 INFO - no previously-included directories found matching 'build' 19:02:55 INFO - no previously-included directories found matching 'dist' 19:02:55 INFO - no previously-included directories found matching '.git*' 19:02:55 INFO - Installing collected packages: jsonschema, functools32 19:02:55 INFO - Running setup.py install for functools32 19:02:55 INFO - warning: no files found matching '*.txt' 19:02:55 INFO - no previously-included directories found matching 'build' 19:02:55 INFO - no previously-included directories found matching 'dist' 19:02:55 INFO - no previously-included directories found matching '.git*' 19:02:55 INFO - Successfully installed jsonschema functools32 19:02:55 INFO - Cleaning up... 19:02:55 INFO - Return code: 0 19:02:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:02:55 INFO - Using env: {'DISPLAY': ':0', 19:02:55 INFO - 'HOME': '/home/cltbld', 19:02:55 INFO - 'LANG': 'en_US.UTF-8', 19:02:55 INFO - 'LANGUAGE': 'en_US:en', 19:02:55 INFO - 'LOGNAME': 'cltbld', 19:02:55 INFO - 'MAIL': '/var/mail/cltbld', 19:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:55 INFO - 'MOZ_NO_REMOTE': '1', 19:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:55 INFO - 'NO_EM_RESTART': '1', 19:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:55 INFO - 'PWD': '/builds/slave/test', 19:02:55 INFO - 'SHELL': '/bin/bash', 19:02:55 INFO - 'SHLVL': '1', 19:02:55 INFO - 'TERM': 'linux', 19:02:55 INFO - 'TMOUT': '86400', 19:02:55 INFO - 'USER': 'cltbld', 19:02:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:55 INFO - '_': '/tools/buildbot/bin/python'} 19:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:02:55 INFO - Cleaning up... 19:02:55 INFO - Return code: 0 19:02:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:02:55 INFO - Using env: {'DISPLAY': ':0', 19:02:55 INFO - 'HOME': '/home/cltbld', 19:02:55 INFO - 'LANG': 'en_US.UTF-8', 19:02:55 INFO - 'LANGUAGE': 'en_US:en', 19:02:55 INFO - 'LOGNAME': 'cltbld', 19:02:55 INFO - 'MAIL': '/var/mail/cltbld', 19:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:55 INFO - 'MOZ_NO_REMOTE': '1', 19:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:55 INFO - 'NO_EM_RESTART': '1', 19:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:55 INFO - 'PWD': '/builds/slave/test', 19:02:55 INFO - 'SHELL': '/bin/bash', 19:02:55 INFO - 'SHLVL': '1', 19:02:55 INFO - 'TERM': 'linux', 19:02:55 INFO - 'TMOUT': '86400', 19:02:55 INFO - 'USER': 'cltbld', 19:02:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:55 INFO - '_': '/tools/buildbot/bin/python'} 19:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:02:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:57 INFO - Downloading docopt-0.6.1.tar.gz 19:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:57 INFO - Running setup.py install for blobuploader 19:02:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:02:57 INFO - Running setup.py install for requests 19:02:58 INFO - Running setup.py install for docopt 19:02:58 INFO - Successfully installed blobuploader requests docopt 19:02:58 INFO - Cleaning up... 19:02:58 INFO - Return code: 0 19:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:58 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/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:02:58 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:02:58 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:02:58 INFO - Using env: {'DISPLAY': ':0', 19:02:58 INFO - 'HOME': '/home/cltbld', 19:02:58 INFO - 'LANG': 'en_US.UTF-8', 19:02:58 INFO - 'LANGUAGE': 'en_US:en', 19:02:58 INFO - 'LOGNAME': 'cltbld', 19:02:58 INFO - 'MAIL': '/var/mail/cltbld', 19:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:58 INFO - 'MOZ_NO_REMOTE': '1', 19:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:58 INFO - 'NO_EM_RESTART': '1', 19:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:58 INFO - 'PWD': '/builds/slave/test', 19:02:58 INFO - 'SHELL': '/bin/bash', 19:02:58 INFO - 'SHLVL': '1', 19:02:58 INFO - 'TERM': 'linux', 19:02:58 INFO - 'TMOUT': '86400', 19:02:58 INFO - 'USER': 'cltbld', 19:02:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:58 INFO - '_': '/tools/buildbot/bin/python'} 19:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:58 INFO - Running setup.py (path:/tmp/pip-waSiMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:58 INFO - Running setup.py (path:/tmp/pip-FZ6tRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:58 INFO - Running setup.py (path:/tmp/pip-KGcX0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:58 INFO - Running setup.py (path:/tmp/pip-maBbXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:58 INFO - Running setup.py (path:/tmp/pip-S7spOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:58 INFO - Running setup.py (path:/tmp/pip-ncR6_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:59 INFO - Running setup.py (path:/tmp/pip-cqnrDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:59 INFO - Running setup.py (path:/tmp/pip-TYwBKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:59 INFO - Running setup.py (path:/tmp/pip-KAyuqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:59 INFO - Running setup.py (path:/tmp/pip-AuHtUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:59 INFO - Running setup.py (path:/tmp/pip-9uOJPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:59 INFO - Running setup.py (path:/tmp/pip-YDuy3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:59 INFO - Running setup.py (path:/tmp/pip-PeFPa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:59 INFO - Running setup.py (path:/tmp/pip-naDVmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:59 INFO - Running setup.py (path:/tmp/pip-AO5V4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:59 INFO - Running setup.py (path:/tmp/pip-mhNFNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:59 INFO - Running setup.py (path:/tmp/pip-gm1GSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:59 INFO - Running setup.py install for manifestparser 19:02:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:59 INFO - Running setup.py install for mozcrash 19:03:00 INFO - Running setup.py install for mozdebug 19:03:00 INFO - Running setup.py install for mozdevice 19:03:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Running setup.py install for mozfile 19:03:00 INFO - Running setup.py install for mozhttpd 19:03:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Running setup.py install for mozinfo 19:03:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Running setup.py install for mozInstall 19:03:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Running setup.py install for mozleak 19:03:00 INFO - Running setup.py install for mozlog 19:03:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Running setup.py install for moznetwork 19:03:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:03:00 INFO - Running setup.py install for mozprocess 19:03:01 INFO - Running setup.py install for mozprofile 19:03:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:03:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:03:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:03:01 INFO - Running setup.py install for mozrunner 19:03:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:03:01 INFO - Running setup.py install for mozscreenshot 19:03:01 INFO - Running setup.py install for moztest 19:03:01 INFO - Running setup.py install for mozversion 19:03:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:03:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:03:01 INFO - Cleaning up... 19:03:01 INFO - Return code: 0 19:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:01 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/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:03:01 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:03:01 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:01 INFO - Using env: {'DISPLAY': ':0', 19:03:01 INFO - 'HOME': '/home/cltbld', 19:03:01 INFO - 'LANG': 'en_US.UTF-8', 19:03:01 INFO - 'LANGUAGE': 'en_US:en', 19:03:01 INFO - 'LOGNAME': 'cltbld', 19:03:01 INFO - 'MAIL': '/var/mail/cltbld', 19:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:01 INFO - 'MOZ_NO_REMOTE': '1', 19:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:01 INFO - 'NO_EM_RESTART': '1', 19:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:01 INFO - 'PWD': '/builds/slave/test', 19:03:01 INFO - 'SHELL': '/bin/bash', 19:03:01 INFO - 'SHLVL': '1', 19:03:01 INFO - 'TERM': 'linux', 19:03:01 INFO - 'TMOUT': '86400', 19:03:01 INFO - 'USER': 'cltbld', 19:03:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:01 INFO - '_': '/tools/buildbot/bin/python'} 19:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:01 INFO - Running setup.py (path:/tmp/pip-hULk7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:01 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:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:01 INFO - Running setup.py (path:/tmp/pip-kvJiNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:02 INFO - Running setup.py (path:/tmp/pip-jZ4J5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:02 INFO - Running setup.py (path:/tmp/pip-qdgCS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:02 INFO - Running setup.py (path:/tmp/pip-F1T2dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:02 INFO - Running setup.py (path:/tmp/pip-BG_PD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:02 INFO - Running setup.py (path:/tmp/pip-ytjxSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:02 INFO - Running setup.py (path:/tmp/pip-KDxlOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:02 INFO - Running setup.py (path:/tmp/pip-aqu_ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:02 INFO - Running setup.py (path:/tmp/pip-hDJVmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:02 INFO - Running setup.py (path:/tmp/pip-7seBkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:02 INFO - Running setup.py (path:/tmp/pip-VYs8lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:02 INFO - Running setup.py (path:/tmp/pip-i379Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:02 INFO - Running setup.py (path:/tmp/pip-D_snmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:02 INFO - Running setup.py (path:/tmp/pip-r7POF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:02 INFO - Running setup.py (path:/tmp/pip-xroww7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:03 INFO - Running setup.py (path:/tmp/pip-JJaJ0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:03 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:03:03 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:03:03 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:03:03 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:03:03 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:03:04 INFO - Downloading blessings-1.6.tar.gz 19:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:03:04 INFO - Installing collected packages: blessings 19:03:04 INFO - Running setup.py install for blessings 19:03:04 INFO - Successfully installed blessings 19:03:04 INFO - Cleaning up... 19:03:04 INFO - Return code: 0 19:03:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:03:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:04 INFO - Reading from file tmpfile_stdout 19:03:04 INFO - Current package versions: 19:03:04 INFO - argparse == 1.2.1 19:03:04 INFO - blessings == 1.6 19:03:04 INFO - blobuploader == 1.2.4 19:03:04 INFO - docopt == 0.6.1 19:03:04 INFO - functools32 == 3.2.3-2 19:03:04 INFO - jsonschema == 2.5.1 19:03:04 INFO - manifestparser == 1.1 19:03:04 INFO - mozInstall == 1.12 19:03:04 INFO - mozcrash == 1.0 19:03:04 INFO - mozdebug == 0.1 19:03:04 INFO - mozdevice == 0.51 19:03:04 INFO - mozfile == 1.2 19:03:04 INFO - mozhttpd == 0.7 19:03:04 INFO - mozinfo == 0.9 19:03:04 INFO - mozleak == 0.1 19:03:04 INFO - mozlog == 3.4 19:03:04 INFO - moznetwork == 0.27 19:03:04 INFO - mozprocess == 0.25 19:03:04 INFO - mozprofile == 0.28 19:03:04 INFO - mozrunner == 6.13 19:03:04 INFO - mozscreenshot == 0.1 19:03:04 INFO - mozsystemmonitor == 0.3 19:03:04 INFO - moztest == 0.8 19:03:04 INFO - mozversion == 1.4 19:03:04 INFO - psutil == 3.1.1 19:03:04 INFO - requests == 1.2.3 19:03:04 INFO - wsgiref == 0.1.2 19:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:04 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/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:03:04 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:03:04 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:04 INFO - Using env: {'DISPLAY': ':0', 19:03:04 INFO - 'HOME': '/home/cltbld', 19:03:04 INFO - 'LANG': 'en_US.UTF-8', 19:03:04 INFO - 'LANGUAGE': 'en_US:en', 19:03:04 INFO - 'LOGNAME': 'cltbld', 19:03:04 INFO - 'MAIL': '/var/mail/cltbld', 19:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:04 INFO - 'MOZ_NO_REMOTE': '1', 19:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:04 INFO - 'NO_EM_RESTART': '1', 19:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:04 INFO - 'PWD': '/builds/slave/test', 19:03:04 INFO - 'SHELL': '/bin/bash', 19:03:04 INFO - 'SHLVL': '1', 19:03:04 INFO - 'TERM': 'linux', 19:03:04 INFO - 'TMOUT': '86400', 19:03:04 INFO - 'USER': 'cltbld', 19:03:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:04 INFO - '_': '/tools/buildbot/bin/python'} 19:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:05 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:03:06 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:03:06 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:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:03:06 INFO - Installing collected packages: marionette-driver 19:03:06 INFO - Running setup.py install for marionette-driver 19:03:06 INFO - Successfully installed marionette-driver 19:03:06 INFO - Cleaning up... 19:03:06 INFO - Return code: 0 19:03:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:06 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/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 0xcb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, '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': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', '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:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:03:06 INFO - Using env: {'DISPLAY': ':0', 19:03:06 INFO - 'HOME': '/home/cltbld', 19:03:06 INFO - 'LANG': 'en_US.UTF-8', 19:03:06 INFO - 'LANGUAGE': 'en_US:en', 19:03:06 INFO - 'LOGNAME': 'cltbld', 19:03:06 INFO - 'MAIL': '/var/mail/cltbld', 19:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:06 INFO - 'MOZ_NO_REMOTE': '1', 19:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:06 INFO - 'NO_EM_RESTART': '1', 19:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:06 INFO - 'PWD': '/builds/slave/test', 19:03:06 INFO - 'SHELL': '/bin/bash', 19:03:06 INFO - 'SHLVL': '1', 19:03:06 INFO - 'TERM': 'linux', 19:03:06 INFO - 'TMOUT': '86400', 19:03:06 INFO - 'USER': 'cltbld', 19:03:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:06 INFO - '_': '/tools/buildbot/bin/python'} 19:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:03:06 INFO - Cleaning up... 19:03:06 INFO - Return code: 0 19:03:06 INFO - Running post-action listener: _resource_record_post_action 19:03:06 INFO - Running post-action listener: _start_resource_monitoring 19:03:06 INFO - Starting resource monitoring. 19:03:06 INFO - [mozharness: 2017-05-26 02:03:06.426916Z] Finished create-virtualenv step (success) 19:03:06 INFO - [mozharness: 2017-05-26 02:03:06.427375Z] Running install step. 19:03:06 INFO - Running pre-action listener: _resource_record_pre_action 19:03:06 INFO - Running main action method: install 19:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:06 INFO - Reading from file tmpfile_stdout 19:03:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:03:06 INFO - Reading from file tmpfile_stdout 19:03:06 INFO - Output received: 19:03:06 INFO - Usage: mozinstall [options] installer 19:03:06 INFO - Options: 19:03:06 INFO - -h, --help show this help message and exit 19:03:06 INFO - -d DEST, --destination=DEST 19:03:06 INFO - Directory to install application into. [default: 19:03:06 INFO - "/builds/slave/test"] 19:03:06 INFO - --app=APP Application being installed. [default: firefox] 19:03:06 INFO - mkdir: /builds/slave/test/build/application 19:03:06 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:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:03:22 INFO - Reading from file tmpfile_stdout 19:03:22 INFO - Output received: 19:03:22 INFO - /builds/slave/test/build/application/firefox/firefox 19:03:22 INFO - Running post-action listener: _resource_record_post_action 19:03:22 INFO - [mozharness: 2017-05-26 02:03:22.217303Z] Finished install step (success) 19:03:22 INFO - [mozharness: 2017-05-26 02:03:22.217580Z] Running run-tests step. 19:03:22 INFO - Running pre-action listener: _resource_record_pre_action 19:03:22 INFO - Running main action method: run_tests 19:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:03:22 INFO - Python 2.7.3 19:03:22 INFO - Return code: 0 19:03:22 INFO - grabbing minidump binary from tooltool 19:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:03:22 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 0x10257a0>, '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 0x10266a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:03:22 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:03:22 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:03:22 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:03:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:03:22 INFO - Return code: 0 19:03:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:03:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:03:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:03:22 INFO - ENV: RUST_BACKTRACE is now 1 19:03:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:03:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:03:22 INFO - Using env: {'DISPLAY': ':0', 19:03:22 INFO - 'HOME': '/home/cltbld', 19:03:22 INFO - 'LANG': 'en_US.UTF-8', 19:03:22 INFO - 'LANGUAGE': 'en_US:en', 19:03:22 INFO - 'LOGNAME': 'cltbld', 19:03:22 INFO - 'MAIL': '/var/mail/cltbld', 19:03:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:03:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:22 INFO - 'MOZ_NO_REMOTE': '1', 19:03:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:22 INFO - 'NO_EM_RESTART': '1', 19:03:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:22 INFO - 'PWD': '/builds/slave/test', 19:03:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:03:22 INFO - 'RUST_BACKTRACE': '1', 19:03:22 INFO - 'SHELL': '/bin/bash', 19:03:22 INFO - 'SHLVL': '1', 19:03:22 INFO - 'TERM': 'linux', 19:03:22 INFO - 'TMOUT': '86400', 19:03:22 INFO - 'USER': 'cltbld', 19:03:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477', 19:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:22 INFO - '_': '/tools/buildbot/bin/python'} 19:03:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:03:22 INFO - mozversion application_buildid: 20170526012945 19:03:22 INFO - mozversion application_changeset: c2ff59dd31bce41bc9108939e86618017943b88d 19:03:22 INFO - mozversion application_display_name: Nightly 19:03:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:03:22 INFO - mozversion application_name: Firefox 19:03:22 INFO - mozversion application_remotingname: firefox 19:03:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:03:22 INFO - mozversion application_vendor: Mozilla 19:03:22 INFO - mozversion application_version: 55.0a1 19:03:22 INFO - mozversion platform_buildid: 20170526012945 19:03:22 INFO - mozversion platform_changeset: c2ff59dd31bce41bc9108939e86618017943b88d 19:03:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:03:22 INFO - mozversion platform_version: 55.0a1 19:03:22 INFO - using testdate: 1495764202 19:03:22 INFO - actual date: 1495764202 19:03:22 INFO - starting webserver on 'localhost:58056' 19:03:22 INFO - SUITE-START | Running 2 tests 19:03:22 INFO - TEST-START | dromaeo_css 19:03:22 INFO - operating with platform_type : linux_ 19:03:22 INFO - Initialising browser for dromaeo_css test... 19:03:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58056/getInfo.html -profile /tmp/tmpa_m2Tk/profile 19:03:22 INFO - TEST-INFO | started process 27267 (/builds/slave/test/build/application/firefox/firefox http://localhost:58056/getInfo.html) 19:03:57 INFO - TEST-INFO | 27267: killed by SIGTERM 19:03:57 INFO - Browser initialized. 19:03:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:03:57 INFO - TEST-INFO | started process 27464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_m2Tk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:09 INFO - PID 27464 | RSS: Main: 168656896 19:04:09 INFO - PID 27464 | 19:07:13 INFO - PID 27464 | Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58056/tests/dromaeo/cssquery-ext.html) 19:07:15 INFO - PID 27464 | RSS: Main: 166379520 19:07:15 INFO - PID 27464 | 19:10:17 INFO - PID 27464 | Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-ext.html (next: http://localhost:58056/tests/dromaeo/cssquery-jquery.html) 19:10:18 INFO - PID 27464 | RSS: Main: 173187072 19:10:18 INFO - PID 27464 | 19:13:19 INFO - PID 27464 | Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58056/tests/dromaeo/cssquery-mootools.html) 19:13:20 INFO - PID 27464 | RSS: Main: 170721280 19:13:20 INFO - PID 27464 | 19:16:22 INFO - PID 27464 | Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58056/tests/dromaeo/cssquery-prototype.html) 19:16:22 INFO - PID 27464 | RSS: Main: 174870528 19:16:22 INFO - PID 27464 | 19:19:25 INFO - PID 27464 | Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58056/tests/dromaeo/cssquery-yui.html) 19:19:26 INFO - PID 27464 | RSS: Main: 175394816 19:19:26 INFO - PID 27464 | 19:22:27 INFO - PID 27464 | Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-yui.html (next: http://localhost:58056/tests/dromaeo/cssquery-dojo.html) 19:22:28 INFO - PID 27464 | RSS: Main: 171814912 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | __start_tp_report 19:22:28 INFO - PID 27464 | _x_x_mozilla_page_load 19:22:28 INFO - PID 27464 | _x_x_mozilla_page_load_details 19:22:28 INFO - PID 27464 | |i|pagename|runs| 19:22:28 INFO - PID 27464 | |0;dojo.html;2693.6228927950087;2694.057080021991;2709.674839019318;2736.151792944187;2736.9863150684255;5175.741212939347;5179.145441002235;5243.816466423671;5248.134057880455;5273.2090186472;5237.10969135247;5248.317718696574;5296.470352964701;5349.652272602288;5369.221462887879;4482.282834746441;4661.184292748755;4694.694844835083;4728.574428301452;4775.14047471455;4744.4306683198065;4773.0931123086675;4806.735629540374;4809.591184749301;4820.97307982211;4644.6052085572765;4656.627469802408;4699.271612900006;4722.197226471474;4723.834665786715;4732.100900828831;4733.952660473386;4737.549932756383;4776.044791041805;4795.448523419816;4669.906601867943;4695.248760198386;4711.575958163782;4719.9292010619865;4736.431628204603;5184.481551844785;5260.552853007499;5288.762005709752;5306.230596563515;5308.681479111227;5633.63381380209;5722.113072473773;5722.914156287659;5731;5736.282964629421;5691.51622112121;5692.459216374438;5700.743466543974;5706.457886500776;5754.539636829044;5299.072662284123;5322.068637988336;5322.840314790563;5328.467153284718;5375.59683023767;5658.74535645897;5729.8567535811935;5737.168110624019;5740.856478588069;5840.328362238312;5603.719814009283;5624.746886390122;5641.943580564224;5651.4348565143155;5663.631863928831;5535.861603459945;5666.518345940559;5677.744501497443;5684.8863022739315;5688.260526131577;5550.500454959073;5628.324601047819;5681.289838770153;5690.9146362804595;5694.060480020833;5615.410381909923;5688.374278829326;5698.629589076697;5713.5714821388565;5730.684812335278;4814.927776083362;4821.349117869113;4822.807087716452;4827.348307978448;4857.7085374876915;4107.219628270679;4111.1366613011605;4127.814248358771;4133.23535145999;4175.31107367287;4715.056988602225;4730.172219861511;4785.736784476818;4793.664443488922;4815.470298267188;5745.454181852718;5761.366249712528;5764.308283006066;5779.393163717833;5818.21454103699;4822.42130944289;4835.927461088087;4839.322494850724;4839.516048395132;4881.560659540587;4943.950560494349;5017.172166592544;5019.021290848323;5058.4435712071645;5078.365204349457;5303.257543943928;5338.599605029561;5341.5459685927135;5341.813036543703;5365.3293338332705;5582.469665381782;5662.122371032497;5672.404397538199;5720.599558031065;5728.2266893970445;5187.662801917863;5203.297554830049;5258.316418865523;5292.311999440049;5300.522952934254;5614.9719251403485;5619.269494965628;5622.437756224344;5632;5634.943650563606;5587.3015873015875;5647.887042259214;5662.2639056922335;5665.376808550974;5706.6005379624685;5604.747786349542;5606.27118474612;5615.831525054255;5647.802326918538;5665.575081868794;5552.52803511706;5559.610827242216;5562.082256427806;5567.66594004361;5578.107502799533;5357.1696387060065;5455.208994695826;5485.753141108739;5503.862403439946;5578.888422231452;5468.699221542694;5485.9725701371235;5533.087040638249;5544.861378465571;5555.833325000256;5377.08589539787;5377.865553361041;5379.865503362447;5388.488093631099;5423.620346575702 19:22:28 INFO - PID 27464 | |1;ext.html;684.4182444921814;748.2666986353373;765.8238605120824;1054.5623566220015;1055.3878750324811;33987.830060849694;35042.824785876095;35063.47404788924;35212.47181292279;35236.295274094504;36666.08334791631;37018;37128.62871371285;37221.25557488856;37226;6611.966940165293;6799.76200832971;6846.623435711022;6944.791656250321;6979.89530157048;6776.119104516406;6898.517103802736;6902.551334163289;6903.447724182053;6904.723811047552;6843.794686159398;6897.827554311132;6913.654317284141;6918.827029324257;6927.099477067999;6838;6841.897371539431;6889.069975553286;6898.758543451006;6909.067275917787;6768.56004359715;6821.249662537117;6853.725850965955;6855.520113592051;6875.5874647521305;33547;33585.328293433995;33603.15992100193;33673;33934.66065339364;3008.067499075272;3027.5155975043886;3066.4480393529157;3069.693030696935;3074.1085085325453;25621;25662.615060774104;25700.8714956424;25710.87144564284;25723.61414578783;2827.08119861046;2845.487812193804;2846.9430611387656;2847;2861.241770930684;148565;148800;159399;164053;164583;41095.589044109176;41363.1727365451;41413;41608.1678366431;41677.583224167975;42522.787386062875;42599.36100958488;43129.35305970413;43147.568524314986;43220.3516947246;13406.932965335305;13439.596812095653;13451.865481345061;13558.186508809504;13594.728105437836;10877;10946.233763636468;10965.945170274097;10967.177461690246;10985.505652245669;13033.869661303266;13036.739265214643;13038.674033149058;13041.217526948414;13142.60572182817;5244.160934250502;5253.527182553588;5274.945010997816;5335.9466405336225;5400.297961265011;861.5735211070435;918.4672889723944;923.7275003873873;924.1820988425292;945.4610871803144;21157.576848463254;21894.233701820678;25598.616020759702;27007.594886076724;27077.593836092474;976.4125068568351;998.610541888664;1002.1832206751474;1002.8144793213279;1003.5584342889106;10901.618443354444;11915;12025.037996960222;12051.02416777038;12115.757684846254;171098;172371;172414;173040;174228;42758.358624620654;43089;43239;43251.78374108109;43352.13295734068;1196.174639498743;1255.2468518888777;1264.7849865522699;1267.7844766389921;1270.8347914771205;20348.491287717927;21187.576248475252;21803.563928721655;21880;22070.779292207513;30976.84511577428;31108.22229444282;31222;31227.219319516284;31313.8434307827;159008;159535.20232398764;159546;159628.85381619367;159660;28100.578491323056;28372.85813570919;29835.403291934475;31420.52869206918;31664.208394790316;37618.623813761515;37815.2436951265;38214.6178538211;38281.234375312895;38350.61649383471;26781.745258752202;27882.86058569694;28047.71952280451;28157.71842281551;28756;27407.17778466649;27764.44471110607;28352.716472835007;29050;29098.56352154677;30755.231119222197;31159;31168.688313116578;31196;31209.687903120677;26433.33916652099;26517.867410662824;26706.866465667546;26888.731112689406;28117.859410702815;19757.802421976172;22670.206542770924;22888.31335059951;22946;22972.885135574885 19:22:28 INFO - PID 27464 | |2;jquery.html;413.64426593129923;419.88033410478;423.41357220249944;435.14059732029244;439.51214152290953;12032.578859739911;13606.727865442685;17442.56393590159;18284.634307313863;18314.90842545789;18497.35259265926;18677.439676809718;18714.15786289617;19315.517112072204;19501.609967800636;5502.724863756806;5715.342735585398;5716.114002329646;5725.513331366838;5729.742161602738;5204.557612602934;5390.595705322097;5400.891982160354;5406.8918621627545;5408.0535906216455;5337;5359.303290572239;5367.570594352443;5368.382635996872;5393.865153371158;5264.684118952875;5287.202351200591;5364.946350536503;5447;5458.645188062763;4925.408950925876;4939.2838038484215;4941.975290123562;4956.851294461136;4982.277569752366;21881.890590547104;22070.448238793997;22259.554808903893;22379.55240895189;22414.663780043313;1619.5627180661272;1641.4501142117406;1696.4401747423321;1707.3256063854833;1707.940222092221;14643.34104965279;14646.780298295535;14684.48604298855;14800.703985920329;15253.313600887986;2013.476496111007;2042.611903738285;2082.1671331467383;2086.5722526881955;2113.471632091977;80149.59925200336;81437;81499;82803.58598206971;83106.58446707788;11010.119190464744;11012.229143959847;11014.39420831862;11141.665750027512;11282.492287847066;15459.304331305118;15465.14941678196;15470;15472.767908481383;15505.767413488808;7738.342240909586;7853.607319633996;7910;7949.403794715419;8039.678412863537;7299.489035767551;7310.707571697072;7387.519811212254;7591.240875912365;7603.809904752426;6749.122614060239;6878.415334696607;6978.581285122909;7021.22766495685;7066.9365115059045;2074.1081335025783;2077.6883467479997;2083.4999600095866;2085.270155445582;2087.279888438486;780.3834970373341;809.8704207326917;827.7475370012083;829.7096016394214;836.3768992100923;15618.531444056696;15672.294746736425;15694.529164125095;15721.449749258722;15753.527394178192;834.3033566971525;835.1272919798824;841.2470838599419;843.3801156150224;856.1866227084295;8299.128591497927;8547.931508561429;8616.23367209733;8666.783330416663;8955.373123881265;346476;356368;356478;357400;360662;75391.62304188444;75934;75955.26514450909;78672.60663696645;78696.6065169682;1064.2816099133054;1074.1245884604023;1114.5931734916696;1119.2892513254142;1122.8764835868212;17262;17448.73826892572;17954.461366159037;18337.99141047255;18693.25226990905;38416.46334146603;38660.6133938657;39374.60625393824;39661.60338396579;40726;48256.276155858395;48917.755411222715;50514.49485505098;51227;51297;8238.50568965864;8410.789730256793;8461.492310461392;8552.144785521647;8666;12989.090763646833;13001.544945927226;13059.21644701321;13119.934400327937;13468.461261549428;10163.54264058134;10594.894051059391;10782.622608208674;11055.22613417053;11488.770224595293;9644;9730.278783291946;9733.415995040321;9778.315517913963;9803.558839852081;10732.409717465614;10873.130149588173;10913.672589822001;11147.275427097213;11397.316161030365;8176.918230817616;8198.180181981992;8248.958755206186;8384.706535271236;8715.259202967565;10609.363438193734;10736.463176841284;10763.677089687322;10842.891571084503;11204.49579768896 19:22:28 INFO - PID 27464 | |3;mootools.html;1253.5487224599142;1321.9206847589146;1325.2446105719732;1334.432866031936;1344.4554955243125;10429.687109386721;11037.11703063755;11047.116230701535;11055.944720276388;11484.71288217793;10595.947020264888;10842.837357439645;10846.078083362923;10848.78302433951;10866.076383507392;2241.081156725747;2298.2415802785126;2300.7584203658625;2303.3205204464725;2310.237621584873;2217.079911836586;2253.8422310438277;2260.9321720348416;2268.194790849241;2274.351809734226;2169.110664627503;2203.3830527452337;2217.36805010572;2220.555888822234;2222.5109176851547;2037.7350944377283;2131.914723411062;2133.434639820449;2134.6371116910086;2138.1447421031557;2108.7258656374725;2117.110813458336;2118.682197670362;2123.065851025544;2216.8891555422165;10904.727381815439;10928.562857485691;11013.118950483942;11014.953579409943;11016.614418495314;5637.746301416405;5904.61619994699;5909.586328956974;5912.970435147839;5916.1421593868645;3196.5524826524306;3299.3236386540702;3362.1258472797003;3375.662433756629;3395.405803984293;1023.7901230247782;1028.7428142964259;1053.1785207538132;1098.4837126550508;1107.3245320354577;16308.673826523522;16400.83599164005;16411;16420.589485262844;16455.99999999988;4644.9767751161025;4673.369095172108;4796.736179510161;4871.439784424837;4888.364512613409;11340.716482088013;11342.659720208407;11348.659540213806;11352.94323528377;11358.94320528392;5597.552195824324;5605.495505404533;5644.040513112698;5674.177244299553;5693.0891057431445;5166.43169251382;5238.476152384731;5250.711210883438;5266.815661451831;5345.492178243138;3752.155764952918;3872.5352957645264;3883.9029024274055;3902.31709450845;3909.6285852844503;1069.5989004123453;1073.5759375046812;1090.3948308688596;1094.7372630568766;1097.160672085855;704.4610872682402;740.9962950185214;744.1962680305257;749.2619769527012;758.0372926383462;5750.1949727038245;5895.587308888423;5949.881002379928;5987.670678112746;6040.818775436744;529.6821906855932;530.3847536857227;531.2005431825079;542.7123624479033;547.2202111990398;3601.9279614407565;3615.204654975954;3724.944125838115;3872.96127038726;4082.9795851020554;14292;14367.64080897965;14753.33609987553;14798.778018329735;14821.481248156262;14088.506902258372;14348.569542913729;14597.635059123395;14600.488982885548;14605.269736513132;7180.640967951582;7432.665530051161;7469.514481558573;7575.886361704579;7707.807304817312;6233.844153896189;6641.468682505291;6711.362420570038;6797.830054248683;6910.7581234656545;12888.355582220664;13074.673133171747;13118.934405327913;13144.671383215496;13509.189448633113;13184.340782961006;13395.12931659439;13508.189508629514;13590.184588924696;13660.043796934118;8709.477431354138;8810.427322224035;8816.338774591803;8899.777505562413;8910.643574257216;9818.85271720939;9837.163841073589;9930.503474826086;9938.701838944844;9950;8335.749927502186;8360.707375241838;8437.831243375222;8494.660213591635;8508.617112230088;8299.170082991652;8344.624491898001;8428;8590.570471476527;8641.265492432962;7650.923490765021;7716.42126840478;7769.223077692185;7774.92225077742;7777.688892444239;5078.873028174177;5548.195511650869;5667.829965101054;5919;5924.229850119457;5297.894042119213;5386.218998245155;5440;5508.669479831223;5513.125537317332 19:22:28 INFO - PID 27464 | |4;prototype.html;347.7200853313082;383.85029838363045;386.5072033157722;388.01831366642404;389.4878235120816;5345.973270133653;5509.311336082989;5517.089680202766;5551.500364967153;5562.249096371994;5306.9667053039675;5368.275282836826;5373.301470808799;5378.354597448311;5387.81142660006;4060.593940605945;4066.593340665939;4076.69424793141;4078.775667338295;4098.8565400211;3929.1552316252;4030.9395359069636;4096.938545921814;4097.119119389331;4102.323116685759;4073.755574665515;4078.286299897521;4084.4894388201474;4089.037262114187;4091.243120022805;4038.414429907676;4048.3117869962175;4060.65484433822;4062.593740625943;4090.365993271018;3575.1955809942815;3579.3378225028455;3584;3588.2776267391537;3594.658507441789;5209.270702101709;5248.396434410053;5314.123169676998;5324.015057214389;5328.760205790749;4761.833335833229;4793.832215872462;4797.880052998668;4819.6867203631655;4829.879253018703;5595.244641973322;5705.486506214419;5718.59969802114;5729.598928075036;5743.224664670258;4005.7997100144876;4024.6176613221696;4034.6973976951845;4046.5144182698264;4050.655694265991;5748.913766293509;5995.310539287994;6035.185249991283;6076.3316035236085;6123.663198524079;4063.309237429644;4073.7148399612333;4086.8352519532386;4090.8363665453644;4100.835966561363;4135.234981528367;4145.1295228002455;4148.668106551469;4150;4152.522459917148;4692.436907571113;4743.644226682944;4751.857444276678;4769.9046019080115;4774.3077253798;5710.200571919934;5732.885342293131;5736.627119237236;5737.627054241461;5746.454086861741;1412.4773833681397;1431.0483528453462;1434.2541878223265;1434.734574103794;1436.633658417097;915.272358475014;954.7851733360077;969.7527130581798;971.4171497101682;974.8245315843075;4971.328870602495;5006.3992320921;5015.448300686921;5015.623828212899;5024.949750502448;5905.232319798399;5931.775584155942;5939.287285525765;5952.809438112308;5958.553108516879;4743.241081426955;4924.901501969941;4936.950630493721;4963.081829861487;4977.85952040626;3108.533719942027;3144.2296637323543;3148.102790704684;3153.9684603154133;3160.5733226014195;5401.3248343957;5448.700321482277;5464.535514481314;5485.314335708036;5496.230527726121;5959.821205363846;5993.880122397528;6019.54853385989;6028.668423236676;6068.180795592627;5472.425395333433;5483.177523371526;5487.737820301353;5496.917546236809;5498.945010549924;5677.120046392815;5892.35184129754;5899.793507227227;5929.52563794904;5932.49573786233;5803.245578074823;5837.67892765885;5838.94161058384;5845.736941837713;5867.266591676041;5302.920456193237;5522.420145884785;5534.335879694301;5560.106287335438;5569.832905012856;4084.673226141842;4110.876673699674;4125.422440858222;4129.318662420667;4138.668906487534;5779.004208687353;5914.142449344735;6028.859754787163;6044.697765111815;6069.119977603311;5703.515201207943;5766.4233576642;5783.826485205451;5802.216700745345;5819.272590926134;5750.654960702372;5754.798582049608;5785.6817875015595;5794.449527294901;5800.723840755028;5445.346558413015;5598.580106492111;5684.289463817023;5689.34572524165;5694.743736531949;5742.3109226891365;5814.156947242711;5825.446582574648;5854.707264636836;5877.529797616095;5510.448955104457;5547.667139971614;5586.245856809279;5590.9440905592055;5645.576581756302 19:22:28 INFO - PID 27464 | |5;yui.html;741.5031928607832;750.4446709435019;766.7853001159675;771.3790398729025;788.7633709887033;11632.476538555764;11636.243644163123;13624.795628065587;14704;14774.335154918028;14077.22575258363;14646.560603181895;14658.560243192695;14697.412103515846;14716.484923027696;880.3353468131568;904.8552231642939;904.9502277374742;905.7916679163764;905.8595917632745;897.4525539420948;902.1654969153507;906.1980147569416;907.4464576608297;910.1671970147307;930.9162175404213;935.6678379175397;935.8689783430291;936.4802534593298;937.5452905340904;923.4597760310227;926.1571969507715;928.4661319741176;933.244072301438;935.4854829843592;684.7466437418137;686.2177118085386;689.5449003657612;690.7824035428824;691.5055735149342;14593.562193134223;15366.078035317916;15489.457868974532;15513.844861551466;15545.067295962279;15517.224138793015;16431.589210269838;16634;16644.001359918442;16673.24970376336;11632.06943444531;11761.58834440799;12596.622101336974;13032.609021729268;13186.07697461178;3042.710942460463;3047.6190476190477;3048.496997995328;3061;3062.2344413896526;75862.62068689677;76972;77678.61160694217;78262.21737782606;78437.60781196058;12679.873201267868;13115.081944264;13197.538086166938;13208.867911320956;13231.73536529264;23525.88237058838;23745.7625423747;24274.271771846874;24525.264242072768;24562.385940351276;5733.197352370671;5740.138979153077;5751.597388182787;5760.884782304331;5771.249737534094;2848.943021139607;2856.757175640052;2897.217751207162;2904.5207540755537;2914.198595386286;3738.43923411485;3887.8056097195595;3891.2217556488818;3899.6100389960775;3903;676.6549059979347;700.1073631120261;700.1702981966387;709.4395427612128;710.5168485429957;552.5137878666748;584.4663384229414;585.7539833270037;600.1148306248336;616.8797084568556;9748.951255243821;12033.819492707617;12430.502779888884;12601.810972835416;12671.17637353569;603.8007457539002;608.1151923950641;628.0202883501661;634.4195061518751;652.846581053452;4482.551744825491;4786;4818.879528011757;4936.037472692862;4942.654014219042;75220;76120.23879761131;77366.61316693493;79455;80236;65947;66820;68916;69382.3061769386;69685.65157174182;61896;61999.6900015497;62451.68774156191;62973.68513157405;64122;8416.2004609562;8620.224179823595;8763.298936085226;8770.166834150745;9072.183503484453;27160.864195678896;27344.589831152152;27447.725522744517;27459;28034.579481308203;35553.466697999036;35596;35770.8211458941;35821.46267806037;36189.63810361968;11867.76264474723;12090.637280881587;12202.206856554296;12235.632931012084;12254.877451225373;11204.047655949009;11268.549258029587;11603.6518904433;11661.53353865836;11667.299962002307;12642.936785316015;12952;13037.543685970946;13207.735845283232;13261.270630115436;11871.347075910908;11913.642590722293;12175.452104655134;12578.55975040869;12631.81052284198;11867.940660296643;12166.57416990401;12211.389430528616;12211.633650990485;12397;8294.460860044077;8590.65637374523;8592.785180370542;8617.48295102296;8791.560421979004;9724.173445257233;9763.41419514803;9778.706638800848;9789.412635241908;10060.144887684628 19:22:28 INFO - PID 27464 | __end_tp_report 19:22:28 INFO - PID 27464 | __start_cc_report 19:22:28 INFO - PID 27464 | _x_x_mozilla_cycle_collect,328 19:22:28 INFO - PID 27464 | __end_cc_report 19:22:28 INFO - PID 27464 | __startTimestamp1495765348035__endTimestamp 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | ------- Summary: start ------- 19:22:28 INFO - PID 27464 | Number of tests: 6 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | [#0] dojo.html Cycles:165 Average:5203.52 Median:5357.17 stddev:609.36 (11.4%) stddev-sans-first:578.55 19:22:28 INFO - PID 27464 | Values: 2693.6 2694.1 2709.7 2736.2 2737.0 5175.7 5179.1 5243.8 5248.1 5273.2 5237.1 5248.3 5296.5 5349.7 5369.2 4482.3 4661.2 4694.7 4728.6 4775.1 4744.4 4773.1 4806.7 4809.6 4821.0 4644.6 4656.6 4699.3 4722.2 4723.8 4732.1 4734.0 4737.5 4776.0 4795.4 4669.9 4695.2 4711.6 4719.9 4736.4 5184.5 5260.6 5288.8 5306.2 5308.7 5633.6 5722.1 5722.9 5731.0 5736.3 5691.5 5692.5 5700.7 5706.5 5754.5 5299.1 5322.1 5322.8 5328.5 5375.6 5658.7 5729.9 5737.2 5740.9 5840.3 5603.7 5624.7 5641.9 5651.4 5663.6 5535.9 5666.5 5677.7 5684.9 5688.3 5550.5 5628.3 5681.3 5690.9 5694.1 5615.4 5688.4 5698.6 5713.6 5730.7 4814.9 4821.3 4822.8 4827.3 4857.7 4107.2 4111.1 4127.8 4133.2 4175.3 4715.1 4730.2 4785.7 4793.7 4815.5 5745.5 5761.4 5764.3 5779.4 5818.2 4822.4 4835.9 4839.3 4839.5 4881.6 4944.0 5017.2 5019.0 5058.4 5078.4 5303.3 5338.6 5341.5 5341.8 5365.3 5582.5 5662.1 5672.4 5720.6 5728.2 5187.7 5203.3 5258.3 5292.3 5300.5 5615.0 5619.3 5622.4 5632.0 5634.9 5587.3 5647.9 5662.3 5665.4 5706.6 5604.7 5606.3 5615.8 5647.8 5665.6 5552.5 5559.6 5562.1 5567.7 5578.1 5357.2 5455.2 5485.8 5503.9 5578.9 5468.7 5486.0 5533.1 5544.9 5555.8 5377.1 5377.9 5379.9 5388.5 5423.6 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | [#1] ext.html Cycles:180 Average:31346.75 Median:3068.07 stddev:42097.48 (1372.1%) stddev-sans-first:42152.62 19:22:28 INFO - PID 27464 | Values: 684.4 748.3 765.8 1054.6 1055.4 33987.8 35042.8 35063.5 35212.5 35236.3 36666.1 37018.0 37128.6 37221.3 37226.0 6612.0 6799.8 6846.6 6944.8 6979.9 6776.1 6898.5 6902.6 6903.4 6904.7 6843.8 6897.8 6913.7 6918.8 6927.1 6838.0 6841.9 6889.1 6898.8 6909.1 6768.6 6821.2 6853.7 6855.5 6875.6 33547.0 33585.3 33603.2 33673.0 33934.7 3008.1 3027.5 3066.4 3069.7 3074.1 25621.0 25662.6 25700.9 25710.9 25723.6 2827.1 2845.5 2846.9 2847.0 2861.2 148565.0 148800.0 159399.0 164053.0 164583.0 41095.6 41363.2 41413.0 41608.2 41677.6 42522.8 42599.4 43129.4 43147.6 43220.4 13406.9 13439.6 13451.9 13558.2 13594.7 10877.0 10946.2 10965.9 10967.2 10985.5 13033.9 13036.7 13038.7 13041.2 13142.6 5244.2 5253.5 5274.9 5335.9 5400.3 861.6 918.5 923.7 924.2 945.5 21157.6 21894.2 25598.6 27007.6 27077.6 976.4 998.6 1002.2 1002.8 1003.6 10901.6 11915.0 12025.0 12051.0 12115.8 171098.0 172371.0 172414.0 173040.0 174228.0 42758.4 43089.0 43239.0 43251.8 43352.1 1196.2 1255.2 1264.8 1267.8 1270.8 20348.5 21187.6 21803.6 21880.0 22070.8 30976.8 31108.2 31222.0 31227.2 31313.8 159008.0 159535.2 159546.0 159628.9 159660.0 28100.6 28372.9 29835.4 31420.5 31664.2 37618.6 37815.2 38214.6 38281.2 38350.6 26781.7 27882.9 28047.7 28157.7 28756.0 27407.2 27764.4 28352.7 29050.0 29098.6 30755.2 31159.0 31168.7 31196.0 31209.7 26433.3 26517.9 26706.9 26888.7 28117.9 19757.8 22670.2 22888.3 22946.0 22972.9 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | [#2] jquery.html Cycles:180 Average:24296.00 Median:416.76 stddev:59144.11 (14191.3%) stddev-sans-first:59282.84 19:22:28 INFO - PID 27464 | Values: 413.6 419.9 423.4 435.1 439.5 12032.6 13606.7 17442.6 18284.6 18314.9 18497.4 18677.4 18714.2 19315.5 19501.6 5502.7 5715.3 5716.1 5725.5 5729.7 5204.6 5390.6 5400.9 5406.9 5408.1 5337.0 5359.3 5367.6 5368.4 5393.9 5264.7 5287.2 5364.9 5447.0 5458.6 4925.4 4939.3 4942.0 4956.9 4982.3 21881.9 22070.4 22259.6 22379.6 22414.7 1619.6 1641.5 1696.4 1707.3 1707.9 14643.3 14646.8 14684.5 14800.7 15253.3 2013.5 2042.6 2082.2 2086.6 2113.5 80149.6 81437.0 81499.0 82803.6 83106.6 11010.1 11012.2 11014.4 11141.7 11282.5 15459.3 15465.1 15470.0 15472.8 15505.8 7738.3 7853.6 7910.0 7949.4 8039.7 7299.5 7310.7 7387.5 7591.2 7603.8 6749.1 6878.4 6978.6 7021.2 7066.9 2074.1 2077.7 2083.5 2085.3 2087.3 780.4 809.9 827.7 829.7 836.4 15618.5 15672.3 15694.5 15721.4 15753.5 834.3 835.1 841.2 843.4 856.2 8299.1 8547.9 8616.2 8666.8 8955.4 346476.0 356368.0 356478.0 357400.0 360662.0 75391.6 75934.0 75955.3 78672.6 78696.6 1064.3 1074.1 1114.6 1119.3 1122.9 17262.0 17448.7 17954.5 18338.0 18693.3 38416.5 38660.6 39374.6 39661.6 40726.0 48256.3 48917.8 50514.5 51227.0 51297.0 8238.5 8410.8 8461.5 8552.1 8666.0 12989.1 13001.5 13059.2 13119.9 13468.5 10163.5 10594.9 10782.6 11055.2 11488.8 9644.0 9730.3 9733.4 9778.3 9803.6 10732.4 10873.1 10913.7 11147.3 11397.3 8176.9 8198.2 8249.0 8384.7 8715.3 10609.4 10736.5 10763.7 10842.9 11204.5 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | [#3] mootools.html Cycles:180 Average:6636.36 Median:3608.57 stddev:4447.82 (123.3%) stddev-sans-first:4441.91 19:22:28 INFO - PID 27464 | Values: 1253.5 1321.9 1325.2 1334.4 1344.5 10429.7 11037.1 11047.1 11055.9 11484.7 10595.9 10842.8 10846.1 10848.8 10866.1 2241.1 2298.2 2300.8 2303.3 2310.2 2217.1 2253.8 2260.9 2268.2 2274.4 2169.1 2203.4 2217.4 2220.6 2222.5 2037.7 2131.9 2133.4 2134.6 2138.1 2108.7 2117.1 2118.7 2123.1 2216.9 10904.7 10928.6 11013.1 11015.0 11016.6 5637.7 5904.6 5909.6 5913.0 5916.1 3196.6 3299.3 3362.1 3375.7 3395.4 1023.8 1028.7 1053.2 1098.5 1107.3 16308.7 16400.8 16411.0 16420.6 16456.0 4645.0 4673.4 4796.7 4871.4 4888.4 11340.7 11342.7 11348.7 11352.9 11358.9 5597.6 5605.5 5644.0 5674.2 5693.1 5166.4 5238.5 5250.7 5266.8 5345.5 3752.2 3872.5 3883.9 3902.3 3909.6 1069.6 1073.6 1090.4 1094.7 1097.2 704.5 741.0 744.2 749.3 758.0 5750.2 5895.6 5949.9 5987.7 6040.8 529.7 530.4 531.2 542.7 547.2 3601.9 3615.2 3724.9 3873.0 4083.0 14292.0 14367.6 14753.3 14798.8 14821.5 14088.5 14348.6 14597.6 14600.5 14605.3 7180.6 7432.7 7469.5 7575.9 7707.8 6233.8 6641.5 6711.4 6797.8 6910.8 12888.4 13074.7 13118.9 13144.7 13509.2 13184.3 13395.1 13508.2 13590.2 13660.0 8709.5 8810.4 8816.3 8899.8 8910.6 9818.9 9837.2 9930.5 9938.7 9950.0 8335.7 8360.7 8437.8 8494.7 8508.6 8299.2 8344.6 8428.0 8590.6 8641.3 7650.9 7716.4 7769.2 7774.9 7777.7 5078.9 5548.2 5667.8 5919.0 5924.2 5297.9 5386.2 5440.0 5508.7 5513.1 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | [#4] prototype.html Cycles:180 Average:4717.27 Median:5383.08 stddev:1398.88 (26.0%) stddev-sans-first:1363.82 19:22:28 INFO - PID 27464 | Values: 347.7 383.9 386.5 388.0 389.5 5346.0 5509.3 5517.1 5551.5 5562.2 5307.0 5368.3 5373.3 5378.4 5387.8 4060.6 4066.6 4076.7 4078.8 4098.9 3929.2 4030.9 4096.9 4097.1 4102.3 4073.8 4078.3 4084.5 4089.0 4091.2 4038.4 4048.3 4060.7 4062.6 4090.4 3575.2 3579.3 3584.0 3588.3 3594.7 5209.3 5248.4 5314.1 5324.0 5328.8 4761.8 4793.8 4797.9 4819.7 4829.9 5595.2 5705.5 5718.6 5729.6 5743.2 4005.8 4024.6 4034.7 4046.5 4050.7 5748.9 5995.3 6035.2 6076.3 6123.7 4063.3 4073.7 4086.8 4090.8 4100.8 4135.2 4145.1 4148.7 4150.0 4152.5 4692.4 4743.6 4751.9 4769.9 4774.3 5710.2 5732.9 5736.6 5737.6 5746.5 1412.5 1431.0 1434.3 1434.7 1436.6 915.3 954.8 969.8 971.4 974.8 4971.3 5006.4 5015.4 5015.6 5024.9 5905.2 5931.8 5939.3 5952.8 5958.6 4743.2 4924.9 4937.0 4963.1 4977.9 3108.5 3144.2 3148.1 3154.0 3160.6 5401.3 5448.7 5464.5 5485.3 5496.2 5959.8 5993.9 6019.5 6028.7 6068.2 5472.4 5483.2 5487.7 5496.9 5498.9 5677.1 5892.4 5899.8 5929.5 5932.5 5803.2 5837.7 5838.9 5845.7 5867.3 5302.9 5522.4 5534.3 5560.1 5569.8 4084.7 4110.9 4125.4 4129.3 4138.7 5779.0 5914.1 6028.9 6044.7 6069.1 5703.5 5766.4 5783.8 5802.2 5819.3 5750.7 5754.8 5785.7 5794.4 5800.7 5445.3 5598.6 5684.3 5689.3 5694.7 5742.3 5814.2 5825.4 5854.7 5877.5 5510.4 5547.7 5586.2 5590.9 5645.6 19:22:28 INFO - PID 27464 | 19:22:28 INFO - PID 27464 | [#5] yui.html Cycles:180 Average:16273.61 Median:4634.28 stddev:21237.84 (458.3%) stddev-sans-first:21265.39 19:22:28 INFO - PID 27464 | Values: 741.5 750.4 766.8 771.4 788.8 11632.5 11636.2 13624.8 14704.0 14774.3 14077.2 14646.6 14658.6 14697.4 14716.5 880.3 904.9 905.0 905.8 905.9 897.5 902.2 906.2 907.4 910.2 930.9 935.7 935.9 936.5 937.5 923.5 926.2 928.5 933.2 935.5 684.7 686.2 689.5 690.8 691.5 14593.6 15366.1 15489.5 15513.8 15545.1 15517.2 16431.6 16634.0 16644.0 16673.2 11632.1 11761.6 12596.6 13032.6 13186.1 3042.7 3047.6 3048.5 3061.0 3062.2 75862.6 76972.0 77678.6 78262.2 78437.6 12679.9 13115.1 13197.5 13208.9 13231.7 23525.9 23745.8 24274.3 24525.3 24562.4 5733.2 5740.1 5751.6 5760.9 5771.2 2848.9 2856.8 2897.2 2904.5 2914.2 3738.4 3887.8 3891.2 3899.6 3903.0 676.7 700.1 700.2 709.4 710.5 552.5 584.5 585.8 600.1 616.9 9749.0 12033.8 12430.5 12601.8 12671.2 603.8 608.1 628.0 634.4 652.8 4482.6 4786.0 4818.9 4936.0 4942.7 75220.0 76120.2 77366.6 79455.0 80236.0 65947.0 66820.0 68916.0 69382.3 69685.7 61896.0 61999.7 62451.7 62973.7 64122.0 8416.2 8620.2 8763.3 8770.2 9072.2 27160.9 27344.6 27447.7 27459.0 28034.6 35553.5 35596.0 35770.8 35821.5 36189.6 11867.8 12090.6 12202.2 12235.6 12254.9 11204.0 11268.5 11603.7 11661.5 11667.3 12642.9 12952.0 13037.5 13207.7 13261.3 11871.3 11913.6 12175.5 12578.6 12631.8 11867.9 12166.6 12211.4 12211.6 12397.0 8294.5 8590.7 8592.8 8617.5 8791.6 9724.2 9763.4 9778.7 9789.4 10060.1 19:22:28 INFO - PID 27464 | -------- Summary: end -------- 19:22:28 INFO - PID 27464 | 19:22:28 INFO - TEST-INFO | 27464: exit 0 19:22:28 INFO - TEST-OK | dromaeo_css | took 1146254ms 19:22:28 INFO - TEST-START | kraken 19:22:28 INFO - operating with platform_type : linux_ 19:22:28 INFO - Initialising browser for kraken test... 19:22:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58056/getInfo.html -profile /tmp/tmpd8d_52/profile 19:22:28 INFO - TEST-INFO | started process 27873 (/builds/slave/test/build/application/firefox/firefox http://localhost:58056/getInfo.html) 19:23:03 INFO - TEST-INFO | 27873: killed by SIGTERM 19:23:03 INFO - Browser initialized. 19:23:03 INFO - Running cycle 1/1 for kraken test... 19:23:03 INFO - TEST-INFO | started process 28070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd8d_52/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:15 INFO - PID 28070 | RSS: Main: 169332736 19:23:15 INFO - PID 28070 | 19:23:18 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-beat-detection) 19:23:19 INFO - PID 28070 | RSS: Main: 175460352 19:23:19 INFO - PID 28070 | 19:23:22 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-dft) 19:23:22 INFO - PID 28070 | RSS: Main: 174260224 19:23:22 INFO - PID 28070 | 19:23:25 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-fft) 19:23:26 INFO - PID 28070 | RSS: Main: 172281856 19:23:26 INFO - PID 28070 | 19:23:28 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-oscillator) 19:23:29 INFO - PID 28070 | RSS: Main: 172445696 19:23:29 INFO - PID 28070 | 19:23:31 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:23:31 INFO - PID 28070 | RSS: Main: 172969984 19:23:31 INFO - PID 28070 | 19:23:34 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58056/tests/kraken/driver.html?testName=imaging-darkroom) 19:23:35 INFO - PID 28070 | RSS: Main: 173821952 19:23:35 INFO - PID 28070 | 19:23:39 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58056/tests/kraken/driver.html?testName=imaging-desaturate) 19:23:39 INFO - PID 28070 | RSS: Main: 172572672 19:23:39 INFO - PID 28070 | 19:23:42 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58056/tests/kraken/driver.html?testName=json-parse-financial) 19:23:43 INFO - PID 28070 | RSS: Main: 173015040 19:23:43 INFO - PID 28070 | 19:23:44 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:45 INFO - PID 28070 | RSS: Main: 173387776 19:23:45 INFO - PID 28070 | 19:23:47 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:47 INFO - PID 28070 | RSS: Main: 172806144 19:23:47 INFO - PID 28070 | 19:23:50 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:50 INFO - PID 28070 | RSS: Main: 173031424 19:23:50 INFO - PID 28070 | 19:23:53 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:23:54 INFO - PID 28070 | RSS: Main: 173223936 19:23:54 INFO - PID 28070 | 19:23:57 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:23:58 INFO - PID 28070 | RSS: Main: 172974080 19:23:58 INFO - PID 28070 | 19:23:59 INFO - PID 28070 | Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58056/tests/kraken/driver.html?testName=ai-astar) 19:24:00 INFO - PID 28070 | RSS: Main: 174755840 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | __start_tp_report 19:24:00 INFO - PID 28070 | _x_x_mozilla_page_load 19:24:00 INFO - PID 28070 | _x_x_mozilla_page_load_details 19:24:00 INFO - PID 28070 | |i|pagename|runs| 19:24:00 INFO - PID 28070 | |0;ai-astar;102;111;112;111;110;112;111;111;113;115 19:24:00 INFO - PID 28070 | |1;audio-beat-detection;162;124;122;166;123;124;125;123;144;127 19:24:00 INFO - PID 28070 | |2;audio-dft;165;166;166;164;167;168;176;164;164;163 19:24:00 INFO - PID 28070 | |3;audio-fft;75;75;74;108;77;77;75;73;96;75 19:24:00 INFO - PID 28070 | |4;audio-oscillator;83;83;107;84;84;83;116;84;83;106 19:24:00 INFO - PID 28070 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;115;115;113 19:24:00 INFO - PID 28070 | |6;imaging-darkroom;151;150;150;151;149;150;151;150;151;150 19:24:00 INFO - PID 28070 | |7;imaging-desaturate;95;96;95;94;95;94;94;95;95;95 19:24:00 INFO - PID 28070 | |8;json-parse-financial;54;54;54;55;56;58;55;56;55;56 19:24:00 INFO - PID 28070 | |9;json-stringify-tinderbox;56;56;57;56;57;56;57;57;56;56 19:24:00 INFO - PID 28070 | |10;stanford-crypto-aes;86;88;87;88;87;86;88;86;117;85 19:24:00 INFO - PID 28070 | |11;stanford-crypto-ccm;148;148;133;137;133;139;138;135;143;145 19:24:00 INFO - PID 28070 | |12;stanford-crypto-pbkdf2;192;196;188;198;200;202;195;195;195;206 19:24:00 INFO - PID 28070 | |13;stanford-crypto-sha256-iterative;74;76;76;74;73;72;74;72;73;75 19:24:00 INFO - PID 28070 | __end_tp_report 19:24:00 INFO - PID 28070 | __start_cc_report 19:24:00 INFO - PID 28070 | _x_x_mozilla_cycle_collect,907 19:24:00 INFO - PID 28070 | __end_cc_report 19:24:00 INFO - PID 28070 | __startTimestamp1495765440098__endTimestamp 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | ------- Summary: start ------- 19:24:00 INFO - PID 28070 | Number of tests: 14 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:3.39 (3.0%) stddev-sans-first:1.48 19:24:00 INFO - PID 28070 | Values: 102.0 111.0 112.0 111.0 110.0 112.0 111.0 111.0 113.0 115.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:126.00 stddev:17.07 (13.6%) stddev-sans-first:14.80 19:24:00 INFO - PID 28070 | Values: 162.0 124.0 122.0 166.0 123.0 124.0 125.0 123.0 144.0 127.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.00 stddev:3.74 (2.3%) stddev-sans-first:3.94 19:24:00 INFO - PID 28070 | Values: 165.0 166.0 166.0 164.0 167.0 168.0 176.0 164.0 164.0 163.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.74 (15.7%) stddev-sans-first:12.28 19:24:00 INFO - PID 28070 | Values: 75.0 75.0 74.0 108.0 77.0 77.0 75.0 73.0 96.0 75.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:83.00 stddev:12.94 (15.6%) stddev-sans-first:13.38 19:24:00 INFO - PID 28070 | Values: 83.0 83.0 107.0 84.0 84.0 83.0 116.0 84.0 83.0 106.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 19:24:00 INFO - PID 28070 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 113.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 19:24:00 INFO - PID 28070 | Values: 151.0 150.0 150.0 151.0 149.0 150.0 151.0 150.0 151.0 150.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 19:24:00 INFO - PID 28070 | Values: 95.0 96.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.25 (2.3%) stddev-sans-first:1.24 19:24:00 INFO - PID 28070 | Values: 54.0 54.0 54.0 55.0 56.0 58.0 55.0 56.0 55.0 56.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 19:24:00 INFO - PID 28070 | Values: 56.0 56.0 57.0 56.0 57.0 56.0 57.0 57.0 56.0 56.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:87.00 stddev:9.61 (11.0%) stddev-sans-first:10.10 19:24:00 INFO - PID 28070 | Values: 86.0 88.0 87.0 88.0 87.0 86.0 88.0 86.0 117.0 85.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:141.00 stddev:5.76 (4.1%) stddev-sans-first:5.32 19:24:00 INFO - PID 28070 | Values: 148.0 148.0 133.0 137.0 133.0 139.0 138.0 135.0 143.0 145.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.70 Median:197.00 stddev:5.10 (2.6%) stddev-sans-first:5.12 19:24:00 INFO - PID 28070 | Values: 192.0 196.0 188.0 198.0 200.0 202.0 195.0 195.0 195.0 206.0 19:24:00 INFO - PID 28070 | 19:24:00 INFO - PID 28070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.00 stddev:1.45 (2.0%) stddev-sans-first:1.54 19:24:00 INFO - PID 28070 | Values: 74.0 76.0 76.0 74.0 73.0 72.0 74.0 72.0 73.0 75.0 19:24:00 INFO - PID 28070 | -------- Summary: end -------- 19:24:00 INFO - PID 28070 | 19:24:01 INFO - TEST-INFO | 28070: exit 0 19:24:01 INFO - TEST-OK | kraken | took 92394ms 19:24:01 INFO - SUITE-END | took 1238s 19:24:01 INFO - Completed test suite (00:20:38) 19:24:01 INFO - javascript benchmark 19:24:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6759.436099560035, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.6228927950087, 2694.057080021991, 2709.674839019318, 2736.151792944187, 2736.9863150684255, 5175.741212939347, 5179.145441002235, 5243.816466423671, 5248.134057880455, 5273.2090186472, 5237.10969135247, 5248.317718696574, 5296.470352964701, 5349.652272602288, 5369.221462887879, 4482.282834746441, 4661.184292748755, 4694.694844835083, 4728.574428301452, 4775.14047471455, 4744.4306683198065, 4773.0931123086675, 4806.735629540374, 4809.591184749301, 4820.97307982211, 4644.6052085572765, 4656.627469802408, 4699.271612900006, 4722.197226471474, 4723.834665786715, 4732.100900828831, 4733.952660473386, 4737.549932756383, 4776.044791041805, 4795.448523419816, 4669.906601867943, 4695.248760198386, 4711.575958163782, 4719.9292010619865, 4736.431628204603, 5184.481551844785, 5260.552853007499, 5288.762005709752, 5306.230596563515, 5308.681479111227, 5633.63381380209, 5722.113072473773, 5722.914156287659, 5731.0, 5736.282964629421, 5691.51622112121, 5692.459216374438, 5700.743466543974, 5706.457886500776, 5754.539636829044, 5299.072662284123, 5322.068637988336, 5322.840314790563, 5328.467153284718, 5375.59683023767, 5658.74535645897, 5729.8567535811935, 5737.168110624019, 5740.856478588069, 5840.328362238312, 5603.719814009283, 5624.746886390122, 5641.943580564224, 5651.4348565143155, 5663.631863928831, 5535.861603459945, 5666.518345940559, 5677.744501497443, 5684.8863022739315, 5688.260526131577, 5550.500454959073, 5628.324601047819, 5681.289838770153, 5690.9146362804595, 5694.060480020833, 5615.410381909923, 5688.374278829326, 5698.629589076697, 5713.5714821388565, 5730.684812335278, 4814.927776083362, 4821.349117869113, 4822.807087716452, 4827.348307978448, 4857.7085374876915, 4107.219628270679, 4111.1366613011605, 4127.814248358771, 4133.23535145999, 4175.31107367287, 4715.056988602225, 4730.172219861511, 4785.736784476818, 4793.664443488922, 4815.470298267188, 5745.454181852718, 5761.366249712528, 5764.308283006066, 5779.393163717833, 5818.21454103699, 4822.42130944289, 4835.927461088087, 4839.322494850724, 4839.516048395132, 4881.560659540587, 4943.950560494349, 5017.172166592544, 5019.021290848323, 5058.4435712071645, 5078.365204349457, 5303.257543943928, 5338.599605029561, 5341.5459685927135, 5341.813036543703, 5365.3293338332705, 5582.469665381782, 5662.122371032497, 5672.404397538199, 5720.599558031065, 5728.2266893970445, 5187.662801917863, 5203.297554830049, 5258.316418865523, 5292.311999440049, 5300.522952934254, 5614.9719251403485, 5619.269494965628, 5622.437756224344, 5632.0, 5634.943650563606, 5587.3015873015875, 5647.887042259214, 5662.2639056922335, 5665.376808550974, 5706.6005379624685, 5604.747786349542, 5606.27118474612, 5615.831525054255, 5647.802326918538, 5665.575081868794, 5552.52803511706, 5559.610827242216, 5562.082256427806, 5567.66594004361, 5578.107502799533, 5357.1696387060065, 5455.208994695826, 5485.753141108739, 5503.862403439946, 5578.888422231452, 5468.699221542694, 5485.9725701371235, 5533.087040638249, 5544.861378465571, 5555.833325000256, 5377.08589539787, 5377.865553361041, 5379.865503362447, 5388.488093631099, 5423.620346575702], "value": 5158.9120884790345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4182444921814, 748.2666986353373, 765.8238605120824, 1054.5623566220015, 1055.3878750324811, 33987.830060849694, 35042.824785876095, 35063.47404788924, 35212.47181292279, 35236.295274094504, 36666.08334791631, 37018.0, 37128.62871371285, 37221.25557488856, 37226.0, 6611.966940165293, 6799.76200832971, 6846.623435711022, 6944.791656250321, 6979.89530157048, 6776.119104516406, 6898.517103802736, 6902.551334163289, 6903.447724182053, 6904.723811047552, 6843.794686159398, 6897.827554311132, 6913.654317284141, 6918.827029324257, 6927.099477067999, 6838.0, 6841.897371539431, 6889.069975553286, 6898.758543451006, 6909.067275917787, 6768.56004359715, 6821.249662537117, 6853.725850965955, 6855.520113592051, 6875.5874647521305, 33547.0, 33585.328293433995, 33603.15992100193, 33673.0, 33934.66065339364, 3008.067499075272, 3027.5155975043886, 3066.4480393529157, 3069.693030696935, 3074.1085085325453, 25621.0, 25662.615060774104, 25700.8714956424, 25710.87144564284, 25723.61414578783, 2827.08119861046, 2845.487812193804, 2846.9430611387656, 2847.0, 2861.241770930684, 148565.0, 148800.0, 159399.0, 164053.0, 164583.0, 41095.589044109176, 41363.1727365451, 41413.0, 41608.1678366431, 41677.583224167975, 42522.787386062875, 42599.36100958488, 43129.35305970413, 43147.568524314986, 43220.3516947246, 13406.932965335305, 13439.596812095653, 13451.865481345061, 13558.186508809504, 13594.728105437836, 10877.0, 10946.233763636468, 10965.945170274097, 10967.177461690246, 10985.505652245669, 13033.869661303266, 13036.739265214643, 13038.674033149058, 13041.217526948414, 13142.60572182817, 5244.160934250502, 5253.527182553588, 5274.945010997816, 5335.9466405336225, 5400.297961265011, 861.5735211070435, 918.4672889723944, 923.7275003873873, 924.1820988425292, 945.4610871803144, 21157.576848463254, 21894.233701820678, 25598.616020759702, 27007.594886076724, 27077.593836092474, 976.4125068568351, 998.610541888664, 1002.1832206751474, 1002.8144793213279, 1003.5584342889106, 10901.618443354444, 11915.0, 12025.037996960222, 12051.02416777038, 12115.757684846254, 171098.0, 172371.0, 172414.0, 173040.0, 174228.0, 42758.358624620654, 43089.0, 43239.0, 43251.78374108109, 43352.13295734068, 1196.174639498743, 1255.2468518888777, 1264.7849865522699, 1267.7844766389921, 1270.8347914771205, 20348.491287717927, 21187.576248475252, 21803.563928721655, 21880.0, 22070.779292207513, 30976.84511577428, 31108.22229444282, 31222.0, 31227.219319516284, 31313.8434307827, 159008.0, 159535.20232398764, 159546.0, 159628.85381619367, 159660.0, 28100.578491323056, 28372.85813570919, 29835.403291934475, 31420.52869206918, 31664.208394790316, 37618.623813761515, 37815.2436951265, 38214.6178538211, 38281.234375312895, 38350.61649383471, 26781.745258752202, 27882.86058569694, 28047.71952280451, 28157.71842281551, 28756.0, 27407.17778466649, 27764.44471110607, 28352.716472835007, 29050.0, 29098.56352154677, 30755.231119222197, 31159.0, 31168.688313116578, 31196.0, 31209.687903120677, 26433.33916652099, 26517.867410662824, 26706.866465667546, 26888.731112689406, 28117.859410702815, 19757.802421976172, 22670.206542770924, 22888.31335059951, 22946.0, 22972.885135574885], "value": 14873.153069441612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.64426593129923, 419.88033410478, 423.41357220249944, 435.14059732029244, 439.51214152290953, 12032.578859739911, 13606.727865442685, 17442.56393590159, 18284.634307313863, 18314.90842545789, 18497.35259265926, 18677.439676809718, 18714.15786289617, 19315.517112072204, 19501.609967800636, 5502.724863756806, 5715.342735585398, 5716.114002329646, 5725.513331366838, 5729.742161602738, 5204.557612602934, 5390.595705322097, 5400.891982160354, 5406.8918621627545, 5408.0535906216455, 5337.0, 5359.303290572239, 5367.570594352443, 5368.382635996872, 5393.865153371158, 5264.684118952875, 5287.202351200591, 5364.946350536503, 5447.0, 5458.645188062763, 4925.408950925876, 4939.2838038484215, 4941.975290123562, 4956.851294461136, 4982.277569752366, 21881.890590547104, 22070.448238793997, 22259.554808903893, 22379.55240895189, 22414.663780043313, 1619.5627180661272, 1641.4501142117406, 1696.4401747423321, 1707.3256063854833, 1707.940222092221, 14643.34104965279, 14646.780298295535, 14684.48604298855, 14800.703985920329, 15253.313600887986, 2013.476496111007, 2042.611903738285, 2082.1671331467383, 2086.5722526881955, 2113.471632091977, 80149.59925200336, 81437.0, 81499.0, 82803.58598206971, 83106.58446707788, 11010.119190464744, 11012.229143959847, 11014.39420831862, 11141.665750027512, 11282.492287847066, 15459.304331305118, 15465.14941678196, 15470.0, 15472.767908481383, 15505.767413488808, 7738.342240909586, 7853.607319633996, 7910.0, 7949.403794715419, 8039.678412863537, 7299.489035767551, 7310.707571697072, 7387.519811212254, 7591.240875912365, 7603.809904752426, 6749.122614060239, 6878.415334696607, 6978.581285122909, 7021.22766495685, 7066.9365115059045, 2074.1081335025783, 2077.6883467479997, 2083.4999600095866, 2085.270155445582, 2087.279888438486, 780.3834970373341, 809.8704207326917, 827.7475370012083, 829.7096016394214, 836.3768992100923, 15618.531444056696, 15672.294746736425, 15694.529164125095, 15721.449749258722, 15753.527394178192, 834.3033566971525, 835.1272919798824, 841.2470838599419, 843.3801156150224, 856.1866227084295, 8299.128591497927, 8547.931508561429, 8616.23367209733, 8666.783330416663, 8955.373123881265, 346476.0, 356368.0, 356478.0, 357400.0, 360662.0, 75391.62304188444, 75934.0, 75955.26514450909, 78672.60663696645, 78696.6065169682, 1064.2816099133054, 1074.1245884604023, 1114.5931734916696, 1119.2892513254142, 1122.8764835868212, 17262.0, 17448.73826892572, 17954.461366159037, 18337.99141047255, 18693.25226990905, 38416.46334146603, 38660.6133938657, 39374.60625393824, 39661.60338396579, 40726.0, 48256.276155858395, 48917.755411222715, 50514.49485505098, 51227.0, 51297.0, 8238.50568965864, 8410.789730256793, 8461.492310461392, 8552.144785521647, 8666.0, 12989.090763646833, 13001.544945927226, 13059.21644701321, 13119.934400327937, 13468.461261549428, 10163.54264058134, 10594.894051059391, 10782.622608208674, 11055.22613417053, 11488.770224595293, 9644.0, 9730.278783291946, 9733.415995040321, 9778.315517913963, 9803.558839852081, 10732.409717465614, 10873.130149588173, 10913.672589822001, 11147.275427097213, 11397.316161030365, 8176.918230817616, 8198.180181981992, 8248.958755206186, 8384.706535271236, 8715.259202967565, 10609.363438193734, 10736.463176841284, 10763.677089687322, 10842.891571084503, 11204.49579768896], "value": 8767.001182594358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.5487224599142, 1321.9206847589146, 1325.2446105719732, 1334.432866031936, 1344.4554955243125, 10429.687109386721, 11037.11703063755, 11047.116230701535, 11055.944720276388, 11484.71288217793, 10595.947020264888, 10842.837357439645, 10846.078083362923, 10848.78302433951, 10866.076383507392, 2241.081156725747, 2298.2415802785126, 2300.7584203658625, 2303.3205204464725, 2310.237621584873, 2217.079911836586, 2253.8422310438277, 2260.9321720348416, 2268.194790849241, 2274.351809734226, 2169.110664627503, 2203.3830527452337, 2217.36805010572, 2220.555888822234, 2222.5109176851547, 2037.7350944377283, 2131.914723411062, 2133.434639820449, 2134.6371116910086, 2138.1447421031557, 2108.7258656374725, 2117.110813458336, 2118.682197670362, 2123.065851025544, 2216.8891555422165, 10904.727381815439, 10928.562857485691, 11013.118950483942, 11014.953579409943, 11016.614418495314, 5637.746301416405, 5904.61619994699, 5909.586328956974, 5912.970435147839, 5916.1421593868645, 3196.5524826524306, 3299.3236386540702, 3362.1258472797003, 3375.662433756629, 3395.405803984293, 1023.7901230247782, 1028.7428142964259, 1053.1785207538132, 1098.4837126550508, 1107.3245320354577, 16308.673826523522, 16400.83599164005, 16411.0, 16420.589485262844, 16455.99999999988, 4644.9767751161025, 4673.369095172108, 4796.736179510161, 4871.439784424837, 4888.364512613409, 11340.716482088013, 11342.659720208407, 11348.659540213806, 11352.94323528377, 11358.94320528392, 5597.552195824324, 5605.495505404533, 5644.040513112698, 5674.177244299553, 5693.0891057431445, 5166.43169251382, 5238.476152384731, 5250.711210883438, 5266.815661451831, 5345.492178243138, 3752.155764952918, 3872.5352957645264, 3883.9029024274055, 3902.31709450845, 3909.6285852844503, 1069.5989004123453, 1073.5759375046812, 1090.3948308688596, 1094.7372630568766, 1097.160672085855, 704.4610872682402, 740.9962950185214, 744.1962680305257, 749.2619769527012, 758.0372926383462, 5750.1949727038245, 5895.587308888423, 5949.881002379928, 5987.670678112746, 6040.818775436744, 529.6821906855932, 530.3847536857227, 531.2005431825079, 542.7123624479033, 547.2202111990398, 3601.9279614407565, 3615.204654975954, 3724.944125838115, 3872.96127038726, 4082.9795851020554, 14292.0, 14367.64080897965, 14753.33609987553, 14798.778018329735, 14821.481248156262, 14088.506902258372, 14348.569542913729, 14597.635059123395, 14600.488982885548, 14605.269736513132, 7180.640967951582, 7432.665530051161, 7469.514481558573, 7575.886361704579, 7707.807304817312, 6233.844153896189, 6641.468682505291, 6711.362420570038, 6797.830054248683, 6910.7581234656545, 12888.355582220664, 13074.673133171747, 13118.934405327913, 13144.671383215496, 13509.189448633113, 13184.340782961006, 13395.12931659439, 13508.189508629514, 13590.184588924696, 13660.043796934118, 8709.477431354138, 8810.427322224035, 8816.338774591803, 8899.777505562413, 8910.643574257216, 9818.85271720939, 9837.163841073589, 9930.503474826086, 9938.701838944844, 9950.0, 8335.749927502186, 8360.707375241838, 8437.831243375222, 8494.660213591635, 8508.617112230088, 8299.170082991652, 8344.624491898001, 8428.0, 8590.570471476527, 8641.265492432962, 7650.923490765021, 7716.42126840478, 7769.223077692185, 7774.92225077742, 7777.688892444239, 5078.873028174177, 5548.195511650869, 5667.829965101054, 5919.0, 5924.229850119457, 5297.894042119213, 5386.218998245155, 5440.0, 5508.669479831223, 5513.125537317332], "value": 4852.1484860522405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7200853313082, 383.85029838363045, 386.5072033157722, 388.01831366642404, 389.4878235120816, 5345.973270133653, 5509.311336082989, 5517.089680202766, 5551.500364967153, 5562.249096371994, 5306.9667053039675, 5368.275282836826, 5373.301470808799, 5378.354597448311, 5387.81142660006, 4060.593940605945, 4066.593340665939, 4076.69424793141, 4078.775667338295, 4098.8565400211, 3929.1552316252, 4030.9395359069636, 4096.938545921814, 4097.119119389331, 4102.323116685759, 4073.755574665515, 4078.286299897521, 4084.4894388201474, 4089.037262114187, 4091.243120022805, 4038.414429907676, 4048.3117869962175, 4060.65484433822, 4062.593740625943, 4090.365993271018, 3575.1955809942815, 3579.3378225028455, 3584.0, 3588.2776267391537, 3594.658507441789, 5209.270702101709, 5248.396434410053, 5314.123169676998, 5324.015057214389, 5328.760205790749, 4761.833335833229, 4793.832215872462, 4797.880052998668, 4819.6867203631655, 4829.879253018703, 5595.244641973322, 5705.486506214419, 5718.59969802114, 5729.598928075036, 5743.224664670258, 4005.7997100144876, 4024.6176613221696, 4034.6973976951845, 4046.5144182698264, 4050.655694265991, 5748.913766293509, 5995.310539287994, 6035.185249991283, 6076.3316035236085, 6123.663198524079, 4063.309237429644, 4073.7148399612333, 4086.8352519532386, 4090.8363665453644, 4100.835966561363, 4135.234981528367, 4145.1295228002455, 4148.668106551469, 4150.0, 4152.522459917148, 4692.436907571113, 4743.644226682944, 4751.857444276678, 4769.9046019080115, 4774.3077253798, 5710.200571919934, 5732.885342293131, 5736.627119237236, 5737.627054241461, 5746.454086861741, 1412.4773833681397, 1431.0483528453462, 1434.2541878223265, 1434.734574103794, 1436.633658417097, 915.272358475014, 954.7851733360077, 969.7527130581798, 971.4171497101682, 974.8245315843075, 4971.328870602495, 5006.3992320921, 5015.448300686921, 5015.623828212899, 5024.949750502448, 5905.232319798399, 5931.775584155942, 5939.287285525765, 5952.809438112308, 5958.553108516879, 4743.241081426955, 4924.901501969941, 4936.950630493721, 4963.081829861487, 4977.85952040626, 3108.533719942027, 3144.2296637323543, 3148.102790704684, 3153.9684603154133, 3160.5733226014195, 5401.3248343957, 5448.700321482277, 5464.535514481314, 5485.314335708036, 5496.230527726121, 5959.821205363846, 5993.880122397528, 6019.54853385989, 6028.668423236676, 6068.180795592627, 5472.425395333433, 5483.177523371526, 5487.737820301353, 5496.917546236809, 5498.945010549924, 5677.120046392815, 5892.35184129754, 5899.793507227227, 5929.52563794904, 5932.49573786233, 5803.245578074823, 5837.67892765885, 5838.94161058384, 5845.736941837713, 5867.266591676041, 5302.920456193237, 5522.420145884785, 5534.335879694301, 5560.106287335438, 5569.832905012856, 4084.673226141842, 4110.876673699674, 4125.422440858222, 4129.318662420667, 4138.668906487534, 5779.004208687353, 5914.142449344735, 6028.859754787163, 6044.697765111815, 6069.119977603311, 5703.515201207943, 5766.4233576642, 5783.826485205451, 5802.216700745345, 5819.272590926134, 5750.654960702372, 5754.798582049608, 5785.6817875015595, 5794.449527294901, 5800.723840755028, 5445.346558413015, 5598.580106492111, 5684.289463817023, 5689.34572524165, 5694.743736531949, 5742.3109226891365, 5814.156947242711, 5825.446582574648, 5854.707264636836, 5877.529797616095, 5510.448955104457, 5547.667139971614, 5586.245856809279, 5590.9440905592055, 5645.576581756302], "value": 4285.401505124978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.5031928607832, 750.4446709435019, 766.7853001159675, 771.3790398729025, 788.7633709887033, 11632.476538555764, 11636.243644163123, 13624.795628065587, 14704.0, 14774.335154918028, 14077.22575258363, 14646.560603181895, 14658.560243192695, 14697.412103515846, 14716.484923027696, 880.3353468131568, 904.8552231642939, 904.9502277374742, 905.7916679163764, 905.8595917632745, 897.4525539420948, 902.1654969153507, 906.1980147569416, 907.4464576608297, 910.1671970147307, 930.9162175404213, 935.6678379175397, 935.8689783430291, 936.4802534593298, 937.5452905340904, 923.4597760310227, 926.1571969507715, 928.4661319741176, 933.244072301438, 935.4854829843592, 684.7466437418137, 686.2177118085386, 689.5449003657612, 690.7824035428824, 691.5055735149342, 14593.562193134223, 15366.078035317916, 15489.457868974532, 15513.844861551466, 15545.067295962279, 15517.224138793015, 16431.589210269838, 16634.0, 16644.001359918442, 16673.24970376336, 11632.06943444531, 11761.58834440799, 12596.622101336974, 13032.609021729268, 13186.07697461178, 3042.710942460463, 3047.6190476190477, 3048.496997995328, 3061.0, 3062.2344413896526, 75862.62068689677, 76972.0, 77678.61160694217, 78262.21737782606, 78437.60781196058, 12679.873201267868, 13115.081944264, 13197.538086166938, 13208.867911320956, 13231.73536529264, 23525.88237058838, 23745.7625423747, 24274.271771846874, 24525.264242072768, 24562.385940351276, 5733.197352370671, 5740.138979153077, 5751.597388182787, 5760.884782304331, 5771.249737534094, 2848.943021139607, 2856.757175640052, 2897.217751207162, 2904.5207540755537, 2914.198595386286, 3738.43923411485, 3887.8056097195595, 3891.2217556488818, 3899.6100389960775, 3903.0, 676.6549059979347, 700.1073631120261, 700.1702981966387, 709.4395427612128, 710.5168485429957, 552.5137878666748, 584.4663384229414, 585.7539833270037, 600.1148306248336, 616.8797084568556, 9748.951255243821, 12033.819492707617, 12430.502779888884, 12601.810972835416, 12671.17637353569, 603.8007457539002, 608.1151923950641, 628.0202883501661, 634.4195061518751, 652.846581053452, 4482.551744825491, 4786.0, 4818.879528011757, 4936.037472692862, 4942.654014219042, 75220.0, 76120.23879761131, 77366.61316693493, 79455.0, 80236.0, 65947.0, 66820.0, 68916.0, 69382.3061769386, 69685.65157174182, 61896.0, 61999.6900015497, 62451.68774156191, 62973.68513157405, 64122.0, 8416.2004609562, 8620.224179823595, 8763.298936085226, 8770.166834150745, 9072.183503484453, 27160.864195678896, 27344.589831152152, 27447.725522744517, 27459.0, 28034.579481308203, 35553.466697999036, 35596.0, 35770.8211458941, 35821.46267806037, 36189.63810361968, 11867.76264474723, 12090.637280881587, 12202.206856554296, 12235.632931012084, 12254.877451225373, 11204.047655949009, 11268.549258029587, 11603.6518904433, 11661.53353865836, 11667.299962002307, 12642.936785316015, 12952.0, 13037.543685970946, 13207.735845283232, 13261.270630115436, 11871.347075910908, 11913.642590722293, 12175.452104655134, 12578.55975040869, 12631.81052284198, 11867.940660296643, 12166.57416990401, 12211.389430528616, 12211.633650990485, 12397.0, 8294.460860044077, 8590.65637374523, 8592.785180370542, 8617.48295102296, 8791.560421979004, 9724.173445257233, 9763.41419514803, 9778.706638800848, 9789.412635241908, 10060.144887684628], "value": 6818.565363863119, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 111.0, 110.0, 112.0, 111.0, 111.0, 113.0, 115.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 124.0, 122.0, 166.0, 123.0, 124.0, 125.0, 123.0, 144.0, 127.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 164.0, 167.0, 168.0, 176.0, 164.0, 164.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 108.0, 77.0, 77.0, 75.0, 73.0, 96.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 107.0, 84.0, 84.0, 83.0, 116.0, 84.0, 83.0, 106.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 149.0, 150.0, 151.0, 150.0, 151.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 56.0, 58.0, 55.0, 56.0, 55.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 87.0, 88.0, 87.0, 86.0, 88.0, 86.0, 117.0, 85.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 133.0, 137.0, 133.0, 139.0, 138.0, 135.0, 143.0, 145.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 196.0, 188.0, 198.0, 200.0, 202.0, 195.0, 195.0, 195.0, 206.0], "value": 196.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 74.0, 73.0, 72.0, 74.0, 72.0, 73.0, 75.0], "value": 73.9, "unit": "score"}]}]} 19:24:01 INFO - Return code: 0 19:24:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:24:01 INFO - # TBPL SUCCESS # 19:24:01 INFO - Running post-action listener: _resource_record_post_action 19:24:01 INFO - [mozharness: 2017-05-26 02:24:01.385694Z] Finished run-tests step (success) 19:24:01 INFO - Running post-run listener: _resource_record_post_run 19:24:01 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400289792; Read time: 8; Write time: 316888 19:24:01 INFO - TinderboxPrint: CPU usage
12.6% 19:24:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:24:01 INFO - TinderboxPrint: I/O write bytes / time
400,289,792 / 316,888 19:24:01 INFO - TinderboxPrint: CPU idle
8,744.5 (87.4%) 19:24:01 INFO - TinderboxPrint: CPU user
1,212.5 (12.1%) 19:24:01 INFO - TinderboxPrint: Swap in / out
0 / 0 19:24:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 62054400; Read time: 0; Write time: 30540 19:24:01 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302944256; Read time: 8; Write time: 214340 19:24:02 INFO - Running post-run listener: _upload_blobber_files 19:24:02 INFO - Blob upload gear active. 19:24:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:24:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:24:02 INFO - (blobuploader) - INFO - Open directory for files ... 19:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:03 INFO - (blobuploader) - INFO - Done attempting. 19:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:04 INFO - (blobuploader) - INFO - Done attempting. 19:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:07 INFO - (blobuploader) - INFO - Done attempting. 19:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:24:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:08 INFO - (blobuploader) - INFO - Done attempting. 19:24:08 INFO - (blobuploader) - INFO - Iteration through files over. 19:24:08 INFO - Return code: 0 19:24:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:24:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:24:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40cbd06d27e1cea072d5238ffed884cc4d853f8c6a7f48d30a4f492c72943f86a99c3770487891f1796216bc6a6b4663858f2d73f22dd079fd0a0ebbbb99dc55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf4351a9ebabc9fbfa51dac14fc90fad86399231fb13cf059b6e3d976d220d3d60211d9788ae9a5769bac8ee1c53276c992646cf4038b3c3b1e65987ce8d4f6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/769522f2a76577a85434b146ec035fe449b8fcea0db638d76d4e047821bd9025cd50fd4f7060ddc007ca8263c4242f994b5426f72935c337c138a3707f90f4bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74a6a761031edb6d00d7ab9cf774d444ba57b410953aa96b9f6e4c9e10cfd9d7ec68a18701e8daba4925f27c655df219910b704f90419a644239d3e7423e407d"} 19:24:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:24:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:24:08 INFO - Contents: 19:24:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40cbd06d27e1cea072d5238ffed884cc4d853f8c6a7f48d30a4f492c72943f86a99c3770487891f1796216bc6a6b4663858f2d73f22dd079fd0a0ebbbb99dc55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf4351a9ebabc9fbfa51dac14fc90fad86399231fb13cf059b6e3d976d220d3d60211d9788ae9a5769bac8ee1c53276c992646cf4038b3c3b1e65987ce8d4f6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/769522f2a76577a85434b146ec035fe449b8fcea0db638d76d4e047821bd9025cd50fd4f7060ddc007ca8263c4242f994b5426f72935c337c138a3707f90f4bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74a6a761031edb6d00d7ab9cf774d444ba57b410953aa96b9f6e4c9e10cfd9d7ec68a18701e8daba4925f27c655df219910b704f90419a644239d3e7423e407d"} 19:24:08 INFO - Running post-run listener: copy_logs_to_upload_dir 19:24:08 INFO - Copying logs to upload dir... 19:24:08 INFO - mkdir: /builds/slave/test/build/upload/logs 19:24:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.493372 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-05-25 19:24:08.156062) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.160554) ========= 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=836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40cbd06d27e1cea072d5238ffed884cc4d853f8c6a7f48d30a4f492c72943f86a99c3770487891f1796216bc6a6b4663858f2d73f22dd079fd0a0ebbbb99dc55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf4351a9ebabc9fbfa51dac14fc90fad86399231fb13cf059b6e3d976d220d3d60211d9788ae9a5769bac8ee1c53276c992646cf4038b3c3b1e65987ce8d4f6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/769522f2a76577a85434b146ec035fe449b8fcea0db638d76d4e047821bd9025cd50fd4f7060ddc007ca8263c4242f994b5426f72935c337c138a3707f90f4bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74a6a761031edb6d00d7ab9cf774d444ba57b410953aa96b9f6e4c9e10cfd9d7ec68a18701e8daba4925f27c655df219910b704f90419a644239d3e7423e407d"} build_url:https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011485 build_url: 'https://queue.taskcluster.net/v1/task/Iu6WqRooSzam46W6nL4ZbQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40cbd06d27e1cea072d5238ffed884cc4d853f8c6a7f48d30a4f492c72943f86a99c3770487891f1796216bc6a6b4663858f2d73f22dd079fd0a0ebbbb99dc55", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf4351a9ebabc9fbfa51dac14fc90fad86399231fb13cf059b6e3d976d220d3d60211d9788ae9a5769bac8ee1c53276c992646cf4038b3c3b1e65987ce8d4f6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/769522f2a76577a85434b146ec035fe449b8fcea0db638d76d4e047821bd9025cd50fd4f7060ddc007ca8263c4242f994b5426f72935c337c138a3707f90f4bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74a6a761031edb6d00d7ab9cf774d444ba57b410953aa96b9f6e4c9e10cfd9d7ec68a18701e8daba4925f27c655df219910b704f90419a644239d3e7423e407d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.184618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.184895) ========= 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=836cfdc75598d54cb747368e000001a9-1495760753.377489-1457382477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.269981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:24:08.273310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:24:08.273595) ========= ========= Total master_lag: 0.17 =========