builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1494606155.03 results: success (0) revision: 1e2fe13035e13b7b4001ade3b48f226957cef5fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.027805) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.028462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.029056) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.315090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.315457) ========= 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=af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 09:22:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.8K=0.2s 2017-05-12 09:22:35 (48.8 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.484511 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.846833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.847199) ========= 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=af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020450 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.896206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.896585) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1e2fe13035e13b7b4001ade3b48f226957cef5fc --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 1e2fe13035e13b7b4001ade3b48f226957cef5fc --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=af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 09:22:35,908 truncating revision to first 12 chars 2017-05-12 09:22:35,908 Setting DEBUG logging. 2017-05-12 09:22:35,908 attempt 1/10 2017-05-12 09:22:35,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1e2fe13035e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 09:22:36,467 unpacking tar archive at: mozilla-central-1e2fe13035e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.922921 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:36.835373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:36.835779) ========= script_repo_revision: 1e2fe13035e13b7b4001ade3b48f226957cef5fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:36.836218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:36.836627) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:36.848056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 09:22:36.848592) ========= /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=af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:37 INFO - MultiFileLogger online at 20170512 09:22:37 in /builds/slave/test 09:22:37 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 09:22:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:37 INFO - {'append_to_log': False, 09:22:37 INFO - 'base_work_dir': '/builds/slave/test', 09:22:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:22:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:37 INFO - 'branch': 'Firefox-Non-PGO', 09:22:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:37 INFO - 'config_files': ('talos/linux_config.py',), 09:22:37 INFO - 'default_actions': ('clobber', 09:22:37 INFO - 'read-buildbot-config', 09:22:37 INFO - 'download-and-extract', 09:22:37 INFO - 'populate-webroot', 09:22:37 INFO - 'create-virtualenv', 09:22:37 INFO - 'install', 09:22:37 INFO - 'run-tests'), 09:22:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:37 INFO - 'download_minidump_stackwalk': True, 09:22:37 INFO - 'download_symbols': 'ondemand', 09:22:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:37 INFO - 'gecko_profile': False, 09:22:37 INFO - 'gecko_profile_interval': 0, 09:22:37 INFO - 'installer_path': 'installer.exe', 09:22:37 INFO - 'log_level': 'info', 09:22:37 INFO - 'log_name': 'talos', 09:22:37 INFO - 'log_to_console': True, 09:22:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:37 INFO - 'opt_config_files': (), 09:22:37 INFO - 'pip_index': False, 09:22:37 INFO - 'suite': 'dromaeojs-e10s', 09:22:37 INFO - 'system_bits': '32', 09:22:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:37 INFO - 'title': 'talos-linux64-ix-020', 09:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:37 INFO - 'use_talos_json': True, 09:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:37 INFO - 'work_dir': 'build'} 09:22:37 INFO - [mozharness: 2017-05-12 16:22:37.062519Z] Running clobber step. 09:22:37 INFO - Running pre-action listener: _resource_record_pre_action 09:22:37 INFO - Running main action method: clobber 09:22:37 INFO - rmtree: /builds/slave/test/build 09:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:38 INFO - Running post-action listener: _resource_record_post_action 09:22:38 INFO - [mozharness: 2017-05-12 16:22:38.034545Z] Finished clobber step (success) 09:22:38 INFO - [mozharness: 2017-05-12 16:22:38.034645Z] Running read-buildbot-config step. 09:22:38 INFO - Running pre-action listener: _resource_record_pre_action 09:22:38 INFO - Running main action method: read_buildbot_config 09:22:38 INFO - Using buildbot properties: 09:22:38 INFO - { 09:22:38 INFO - "project": "", 09:22:38 INFO - "product": "firefox", 09:22:38 INFO - "who": "ryanvm@gmail.com", 09:22:38 INFO - "installer_path": "public/build/target.tar.bz2", 09:22:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:22:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:22:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:22:38 INFO - "stage_platform": "linux64", 09:22:38 INFO - "basedir": "/builds/slave/test", 09:22:38 INFO - "buildnumber": 876, 09:22:38 INFO - "platform": "ubuntu64_hw", 09:22:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:22:38 INFO - "slavebuilddir": "test", 09:22:38 INFO - "taskId": "ZOP68Sj1SVWKAT5WV3LeRg", 09:22:38 INFO - "branch": "mozilla-central", 09:22:38 INFO - "script_repo_revision": "production", 09:22:38 INFO - "revision": "1e2fe13035e13b7b4001ade3b48f226957cef5fc", 09:22:38 INFO - "slavename": "talos-linux64-ix-020", 09:22:38 INFO - "repo_path": "mozilla-central" 09:22:38 INFO - } 09:22:38 INFO - Finding installer, test and symbols from parent task. 09:22:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZOP68Sj1SVWKAT5WV3LeRg'}, attempt #1 09:22:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZOP68Sj1SVWKAT5WV3LeRg'}, attempt #1 09:22:38 INFO - Task dependencies: NtRFFEQ4TNiztEbolW4n4g 09:22:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g'}, attempt #1 09:22:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:22:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/test_packages.json 09:22:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip 09:22:39 INFO - Running post-action listener: _resource_record_post_action 09:22:39 INFO - [mozharness: 2017-05-12 16:22:39.389118Z] Finished read-buildbot-config step (success) 09:22:39 INFO - [mozharness: 2017-05-12 16:22:39.389333Z] Running download-and-extract step. 09:22:39 INFO - Running pre-action listener: _resource_record_pre_action 09:22:39 INFO - Running main action method: download_and_extract 09:22:39 INFO - mkdir: /builds/slave/test/build/tests 09:22:39 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')]} 09:22:39 INFO - trying https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.test_packages.json 09:22:39 INFO - Downloading https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:22:39 INFO - Downloaded 986 bytes. 09:22:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:22:39 INFO - Using the following test package requirements: 09:22:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:22:39 INFO - u'common': [u'target.common.tests.zip'], 09:22:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:22:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:22:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:22:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:22:39 INFO - u'mozbase': [u'target.common.tests.zip'], 09:22:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:22:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:22:39 INFO - u'web-platform': [u'target.common.tests.zip', 09:22:39 INFO - u'target.web-platform.tests.zip'], 09:22:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:22:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:22:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip 09:22:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:22:39 INFO - Fetch https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip into memory 09:22:41 INFO - Content-Length response header: 62447304 09:22:41 INFO - Bytes received: 62447304 09:22:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:22:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip 09:22:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:22:53 INFO - Fetch https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip into memory 09:22:54 INFO - Content-Length response header: 62447304 09:22:54 INFO - Bytes received: 62447304 09:23:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.talos.tests.zip 09:23:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:23:06 INFO - Fetch https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.talos.tests.zip into memory 09:23:07 INFO - Content-Length response header: 14409411 09:23:07 INFO - Bytes received: 14409411 09:23:07 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')]} 09:23:07 INFO - trying https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:23:07 INFO - Downloading https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:23:08 INFO - Downloaded 63521198 bytes. 09:23:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:23:08 INFO - mkdir: /builds/slave/test/properties 09:23:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:08 INFO - Contents: 09:23:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:23:08 INFO - Running post-action listener: _resource_record_post_action 09:23:08 INFO - Running post-action listener: set_extra_try_arguments 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.593272Z] Finished download-and-extract step (success) 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.593378Z] Running populate-webroot step. 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: populate_webroot 09:23:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:08 INFO - '--tppagecycles', 09:23:08 INFO - '7'], 09:23:08 INFO - 'tests': ['tsvgm']}}, 09:23:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['damp', 'tps']}, 09:23:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'tests': ['damp', 'tps']}, 09:23:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['dromaeo_dom']}, 09:23:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:23:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:23:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:23:08 INFO - 'bloom_basic_ref']}, 09:23:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tsvgx', 09:23:08 INFO - 'tsvgr_opacity', 09:23:08 INFO - 'tart', 09:23:08 INFO - 'tscrollx', 09:23:08 INFO - 'cart', 09:23:08 INFO - 'tsvg_static']}, 09:23:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:08 INFO - 'tsvgr_opacity', 09:23:08 INFO - 'tart', 09:23:08 INFO - 'tscrollx', 09:23:08 INFO - 'cart', 09:23:08 INFO - 'tsvg_static']}, 09:23:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tp5o']}, 09:23:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s', 09:23:08 INFO - '--xperf_path', 09:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:08 INFO - 'tests': ['tp5n']}, 09:23:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--xperf_path', 09:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:08 INFO - 'tests': ['tp5n']}}, 09:23:08 INFO - 'talos.zip': {'path': '', 09:23:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:08 INFO - Running post-action listener: _resource_record_post_action 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.607034Z] Finished populate-webroot step (success) 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.607123Z] Running create-virtualenv step. 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: create_virtualenv 09:23:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:23:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:08 INFO - Using real prefix '/usr' 09:23:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:11 INFO - Installing pip.................done. 09:23:11 INFO - Return code: 0 09:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:11 INFO - Reading from file tmpfile_stdout 09:23:11 INFO - Output received: 09:23:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:23:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:11 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')]} 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:11 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')]} 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:11 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:11 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 09:23:11 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 09:23:11 INFO - Using env: {'DISPLAY': ':0', 09:23:11 INFO - 'HOME': '/home/cltbld', 09:23:11 INFO - 'LANG': 'en_US.UTF-8', 09:23:11 INFO - 'LANGUAGE': 'en_US:en', 09:23:11 INFO - 'LOGNAME': 'cltbld', 09:23:11 INFO - 'MAIL': '/var/mail/cltbld', 09:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:11 INFO - 'MOZ_NO_REMOTE': '1', 09:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:11 INFO - 'NO_EM_RESTART': '1', 09:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:11 INFO - 'PWD': '/builds/slave/test', 09:23:11 INFO - 'SHELL': '/bin/bash', 09:23:11 INFO - 'SHLVL': '1', 09:23:11 INFO - 'TERM': 'linux', 09:23:11 INFO - 'TMOUT': '86400', 09:23:11 INFO - 'USER': 'cltbld', 09:23:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:11 INFO - '_': '/tools/buildbot/bin/python'} 09:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:11 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 09:23:11 INFO - Cleaning up... 09:23:11 INFO - Return code: 0 09:23:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:11 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')]} 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:11 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')]} 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:11 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:11 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 09:23:11 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 09:23:11 INFO - Using env: {'DISPLAY': ':0', 09:23:11 INFO - 'HOME': '/home/cltbld', 09:23:11 INFO - 'LANG': 'en_US.UTF-8', 09:23:11 INFO - 'LANGUAGE': 'en_US:en', 09:23:11 INFO - 'LOGNAME': 'cltbld', 09:23:11 INFO - 'MAIL': '/var/mail/cltbld', 09:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:11 INFO - 'MOZ_NO_REMOTE': '1', 09:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:11 INFO - 'NO_EM_RESTART': '1', 09:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:11 INFO - 'PWD': '/builds/slave/test', 09:23:11 INFO - 'SHELL': '/bin/bash', 09:23:11 INFO - 'SHLVL': '1', 09:23:11 INFO - 'TERM': 'linux', 09:23:11 INFO - 'TMOUT': '86400', 09:23:11 INFO - 'USER': 'cltbld', 09:23:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:11 INFO - '_': '/tools/buildbot/bin/python'} 09:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:12 INFO - Downloading/unpacking psutil>=3.1.1 09:23:12 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 09:23:12 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 09:23:12 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 09:23:12 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 09:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:13 INFO - Installing collected packages: psutil 09:23:13 INFO - Running setup.py install for psutil 09:23:13 INFO - building 'psutil._psutil_linux' extension 09:23:13 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 09:23:14 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 09:23:14 INFO - building 'psutil._psutil_posix' extension 09:23:14 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 09:23:14 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 09:23:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:14 INFO - Successfully installed psutil 09:23:14 INFO - Cleaning up... 09:23:14 INFO - Return code: 0 09:23:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:14 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')]} 09:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:14 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')]} 09:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:14 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:14 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 09:23:14 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 09:23:14 INFO - Using env: {'DISPLAY': ':0', 09:23:14 INFO - 'HOME': '/home/cltbld', 09:23:14 INFO - 'LANG': 'en_US.UTF-8', 09:23:14 INFO - 'LANGUAGE': 'en_US:en', 09:23:14 INFO - 'LOGNAME': 'cltbld', 09:23:14 INFO - 'MAIL': '/var/mail/cltbld', 09:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:14 INFO - 'MOZ_NO_REMOTE': '1', 09:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:14 INFO - 'NO_EM_RESTART': '1', 09:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:14 INFO - 'PWD': '/builds/slave/test', 09:23:14 INFO - 'SHELL': '/bin/bash', 09:23:14 INFO - 'SHLVL': '1', 09:23:14 INFO - 'TERM': 'linux', 09:23:14 INFO - 'TMOUT': '86400', 09:23:14 INFO - 'USER': 'cltbld', 09:23:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:14 INFO - '_': '/tools/buildbot/bin/python'} 09:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:15 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 09:23:15 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 09:23:15 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 09:23:15 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 09:23:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:16 INFO - Installing collected packages: mozsystemmonitor 09:23:16 INFO - Running setup.py install for mozsystemmonitor 09:23:16 INFO - Successfully installed mozsystemmonitor 09:23:16 INFO - Cleaning up... 09:23:16 INFO - Return code: 0 09:23:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:16 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')]} 09:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:16 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')]} 09:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:16 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:16 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 09:23:16 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 09:23:16 INFO - Using env: {'DISPLAY': ':0', 09:23:16 INFO - 'HOME': '/home/cltbld', 09:23:16 INFO - 'LANG': 'en_US.UTF-8', 09:23:16 INFO - 'LANGUAGE': 'en_US:en', 09:23:16 INFO - 'LOGNAME': 'cltbld', 09:23:16 INFO - 'MAIL': '/var/mail/cltbld', 09:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:16 INFO - 'MOZ_NO_REMOTE': '1', 09:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:16 INFO - 'NO_EM_RESTART': '1', 09:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:16 INFO - 'PWD': '/builds/slave/test', 09:23:16 INFO - 'SHELL': '/bin/bash', 09:23:16 INFO - 'SHLVL': '1', 09:23:16 INFO - 'TERM': 'linux', 09:23:16 INFO - 'TMOUT': '86400', 09:23:16 INFO - 'USER': 'cltbld', 09:23:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:16 INFO - '_': '/tools/buildbot/bin/python'} 09:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:16 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:16 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 09:23:16 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 09:23:16 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 09:23:16 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 09:23:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:17 INFO - warning: no files found matching '*.txt' 09:23:17 INFO - no previously-included directories found matching 'build' 09:23:17 INFO - no previously-included directories found matching 'dist' 09:23:17 INFO - no previously-included directories found matching '.git*' 09:23:17 INFO - Installing collected packages: jsonschema, functools32 09:23:17 INFO - Running setup.py install for functools32 09:23:17 INFO - warning: no files found matching '*.txt' 09:23:17 INFO - no previously-included directories found matching 'build' 09:23:17 INFO - no previously-included directories found matching 'dist' 09:23:17 INFO - no previously-included directories found matching '.git*' 09:23:17 INFO - Successfully installed jsonschema functools32 09:23:17 INFO - Cleaning up... 09:23:17 INFO - Return code: 0 09:23:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23:17 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')]} 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:17 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')]} 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:17 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:17 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 09:23:17 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 09:23:17 INFO - Using env: {'DISPLAY': ':0', 09:23:17 INFO - 'HOME': '/home/cltbld', 09:23:17 INFO - 'LANG': 'en_US.UTF-8', 09:23:17 INFO - 'LANGUAGE': 'en_US:en', 09:23:17 INFO - 'LOGNAME': 'cltbld', 09:23:17 INFO - 'MAIL': '/var/mail/cltbld', 09:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:17 INFO - 'MOZ_NO_REMOTE': '1', 09:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:17 INFO - 'NO_EM_RESTART': '1', 09:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:17 INFO - 'PWD': '/builds/slave/test', 09:23:17 INFO - 'SHELL': '/bin/bash', 09:23:17 INFO - 'SHLVL': '1', 09:23:17 INFO - 'TERM': 'linux', 09:23:17 INFO - 'TMOUT': '86400', 09:23:17 INFO - 'USER': 'cltbld', 09:23:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:17 INFO - '_': '/tools/buildbot/bin/python'} 09:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:18 INFO - Cleaning up... 09:23:18 INFO - Return code: 0 09:23:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:18 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')]} 09:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:18 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')]} 09:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:18 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:18 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 09:23:18 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 09:23:18 INFO - Using env: {'DISPLAY': ':0', 09:23:18 INFO - 'HOME': '/home/cltbld', 09:23:18 INFO - 'LANG': 'en_US.UTF-8', 09:23:18 INFO - 'LANGUAGE': 'en_US:en', 09:23:18 INFO - 'LOGNAME': 'cltbld', 09:23:18 INFO - 'MAIL': '/var/mail/cltbld', 09:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:18 INFO - 'MOZ_NO_REMOTE': '1', 09:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:18 INFO - 'NO_EM_RESTART': '1', 09:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:18 INFO - 'PWD': '/builds/slave/test', 09:23:18 INFO - 'SHELL': '/bin/bash', 09:23:18 INFO - 'SHLVL': '1', 09:23:18 INFO - 'TERM': 'linux', 09:23:18 INFO - 'TMOUT': '86400', 09:23:18 INFO - 'USER': 'cltbld', 09:23:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:18 INFO - '_': '/tools/buildbot/bin/python'} 09:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:18 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 09:23:18 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 09:23:18 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 09:23:18 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 09:23:19 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:19 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 09:23:19 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 09:23:19 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 09:23:19 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 09:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:19 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 09:23:19 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 09:23:19 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 09:23:19 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 09:23:19 INFO - Downloading docopt-0.6.1.tar.gz 09:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:20 INFO - Running setup.py install for blobuploader 09:23:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:20 INFO - Running setup.py install for requests 09:23:20 INFO - Running setup.py install for docopt 09:23:20 INFO - Successfully installed blobuploader requests docopt 09:23:20 INFO - Cleaning up... 09:23:20 INFO - Return code: 0 09:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:20 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')]} 09:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:20 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')]} 09:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:20 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:20 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 09:23:20 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 09:23:20 INFO - Using env: {'DISPLAY': ':0', 09:23:20 INFO - 'HOME': '/home/cltbld', 09:23:20 INFO - 'LANG': 'en_US.UTF-8', 09:23:20 INFO - 'LANGUAGE': 'en_US:en', 09:23:20 INFO - 'LOGNAME': 'cltbld', 09:23:20 INFO - 'MAIL': '/var/mail/cltbld', 09:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:20 INFO - 'MOZ_NO_REMOTE': '1', 09:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:20 INFO - 'NO_EM_RESTART': '1', 09:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:20 INFO - 'PWD': '/builds/slave/test', 09:23:20 INFO - 'SHELL': '/bin/bash', 09:23:20 INFO - 'SHLVL': '1', 09:23:20 INFO - 'TERM': 'linux', 09:23:20 INFO - 'TMOUT': '86400', 09:23:20 INFO - 'USER': 'cltbld', 09:23:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:20 INFO - '_': '/tools/buildbot/bin/python'} 09:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:20 INFO - Running setup.py (path:/tmp/pip-hqM9AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:20 INFO - Running setup.py (path:/tmp/pip-FVa8we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:21 INFO - Running setup.py (path:/tmp/pip-d9MC9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:21 INFO - Running setup.py (path:/tmp/pip-_g5kMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:21 INFO - Running setup.py (path:/tmp/pip-rhobQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:21 INFO - Running setup.py (path:/tmp/pip-BCcN7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:21 INFO - Running setup.py (path:/tmp/pip-u5T6wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:21 INFO - Running setup.py (path:/tmp/pip-3EjlUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:21 INFO - Running setup.py (path:/tmp/pip-owDdWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:21 INFO - Running setup.py (path:/tmp/pip-0ovwcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:21 INFO - Running setup.py (path:/tmp/pip-MmsDwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:21 INFO - Running setup.py (path:/tmp/pip-qa1M6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:21 INFO - Running setup.py (path:/tmp/pip-56xODA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:21 INFO - Running setup.py (path:/tmp/pip-r8rlxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:21 INFO - Running setup.py (path:/tmp/pip-ivFkCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:21 INFO - Running setup.py (path:/tmp/pip-4utY22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:22 INFO - Running setup.py (path:/tmp/pip-oCNDCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:22 INFO - Running setup.py install for manifestparser 09:23:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozcrash 09:23:22 INFO - Running setup.py install for mozdebug 09:23:22 INFO - Running setup.py install for mozdevice 09:23:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozfile 09:23:22 INFO - Running setup.py install for mozhttpd 09:23:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozinfo 09:23:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozInstall 09:23:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozleak 09:23:22 INFO - Running setup.py install for mozlog 09:23:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:23 INFO - Running setup.py install for moznetwork 09:23:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:23 INFO - Running setup.py install for mozprocess 09:23:23 INFO - Running setup.py install for mozprofile 09:23:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:23 INFO - Running setup.py install for mozrunner 09:23:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:23 INFO - Running setup.py install for mozscreenshot 09:23:23 INFO - Running setup.py install for moztest 09:23:23 INFO - Running setup.py install for mozversion 09:23:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:23 INFO - Cleaning up... 09:23:23 INFO - Return code: 0 09:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:23 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')]} 09:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:23 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')]} 09:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:23 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:23 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 09:23:23 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 09:23:23 INFO - Using env: {'DISPLAY': ':0', 09:23:23 INFO - 'HOME': '/home/cltbld', 09:23:23 INFO - 'LANG': 'en_US.UTF-8', 09:23:23 INFO - 'LANGUAGE': 'en_US:en', 09:23:23 INFO - 'LOGNAME': 'cltbld', 09:23:23 INFO - 'MAIL': '/var/mail/cltbld', 09:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:23 INFO - 'MOZ_NO_REMOTE': '1', 09:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:23 INFO - 'NO_EM_RESTART': '1', 09:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:23 INFO - 'PWD': '/builds/slave/test', 09:23:23 INFO - 'SHELL': '/bin/bash', 09:23:23 INFO - 'SHLVL': '1', 09:23:23 INFO - 'TERM': 'linux', 09:23:23 INFO - 'TMOUT': '86400', 09:23:23 INFO - 'USER': 'cltbld', 09:23:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:23 INFO - '_': '/tools/buildbot/bin/python'} 09:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:24 INFO - Running setup.py (path:/tmp/pip-xfy53W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:24 INFO - Running setup.py (path:/tmp/pip-r5DWJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:24 INFO - Running setup.py (path:/tmp/pip-l6f5EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:24 INFO - Running setup.py (path:/tmp/pip-jLmKXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:24 INFO - Running setup.py (path:/tmp/pip-5GvqP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:24 INFO - Running setup.py (path:/tmp/pip-Owfutm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:24 INFO - Running setup.py (path:/tmp/pip-oAv5DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:24 INFO - Running setup.py (path:/tmp/pip-moWFyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:24 INFO - Running setup.py (path:/tmp/pip-8dBeud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:24 INFO - Running setup.py (path:/tmp/pip-U88PL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:24 INFO - Running setup.py (path:/tmp/pip-zzKpvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:24 INFO - Running setup.py (path:/tmp/pip-JT2ajK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:24 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)) 09:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:24 INFO - Running setup.py (path:/tmp/pip-7eMItq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:25 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)) 09:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:25 INFO - Running setup.py (path:/tmp/pip-whKkYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:25 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)) 09:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:25 INFO - Running setup.py (path:/tmp/pip-zl7eO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:25 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)) 09:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:25 INFO - Running setup.py (path:/tmp/pip-IaDXXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:25 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)) 09:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:25 INFO - Running setup.py (path:/tmp/pip-tIex0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:25 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:25 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 09:23:25 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 09:23:25 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 09:23:25 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 09:23:26 INFO - Downloading blessings-1.6.tar.gz 09:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:26 INFO - Installing collected packages: blessings 09:23:26 INFO - Running setup.py install for blessings 09:23:26 INFO - Successfully installed blessings 09:23:26 INFO - Cleaning up... 09:23:26 INFO - Return code: 0 09:23:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:26 INFO - Reading from file tmpfile_stdout 09:23:26 INFO - Current package versions: 09:23:26 INFO - argparse == 1.2.1 09:23:26 INFO - blessings == 1.6 09:23:26 INFO - blobuploader == 1.2.4 09:23:26 INFO - docopt == 0.6.1 09:23:26 INFO - functools32 == 3.2.3-2 09:23:26 INFO - jsonschema == 2.5.1 09:23:26 INFO - manifestparser == 1.1 09:23:26 INFO - mozInstall == 1.12 09:23:26 INFO - mozcrash == 1.0 09:23:26 INFO - mozdebug == 0.1 09:23:26 INFO - mozdevice == 0.50 09:23:26 INFO - mozfile == 1.2 09:23:26 INFO - mozhttpd == 0.7 09:23:26 INFO - mozinfo == 0.9 09:23:26 INFO - mozleak == 0.1 09:23:26 INFO - mozlog == 3.4 09:23:26 INFO - moznetwork == 0.27 09:23:26 INFO - mozprocess == 0.25 09:23:26 INFO - mozprofile == 0.28 09:23:26 INFO - mozrunner == 6.13 09:23:26 INFO - mozscreenshot == 0.1 09:23:26 INFO - mozsystemmonitor == 0.3 09:23:26 INFO - moztest == 0.8 09:23:26 INFO - mozversion == 1.4 09:23:26 INFO - psutil == 3.1.1 09:23:26 INFO - requests == 1.2.3 09:23:26 INFO - wsgiref == 0.1.2 09:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:26 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')]} 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:26 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')]} 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:26 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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:26 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 09:23:26 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 09:23:26 INFO - Using env: {'DISPLAY': ':0', 09:23:26 INFO - 'HOME': '/home/cltbld', 09:23:26 INFO - 'LANG': 'en_US.UTF-8', 09:23:26 INFO - 'LANGUAGE': 'en_US:en', 09:23:26 INFO - 'LOGNAME': 'cltbld', 09:23:26 INFO - 'MAIL': '/var/mail/cltbld', 09:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:26 INFO - 'MOZ_NO_REMOTE': '1', 09:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:26 INFO - 'NO_EM_RESTART': '1', 09:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:26 INFO - 'PWD': '/builds/slave/test', 09:23:26 INFO - 'SHELL': '/bin/bash', 09:23:26 INFO - 'SHLVL': '1', 09:23:26 INFO - 'TERM': 'linux', 09:23:26 INFO - 'TMOUT': '86400', 09:23:26 INFO - 'USER': 'cltbld', 09:23:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:26 INFO - '_': '/tools/buildbot/bin/python'} 09:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 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)) 09:23:27 INFO - Cleaning up... 09:23:27 INFO - Return code: 0 09:23:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:27 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')]} 09:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:27 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')]} 09:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x19b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d23770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, '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': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', '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 09:23:27 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 09:23:27 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 09:23:27 INFO - Using env: {'DISPLAY': ':0', 09:23:27 INFO - 'HOME': '/home/cltbld', 09:23:27 INFO - 'LANG': 'en_US.UTF-8', 09:23:27 INFO - 'LANGUAGE': 'en_US:en', 09:23:27 INFO - 'LOGNAME': 'cltbld', 09:23:27 INFO - 'MAIL': '/var/mail/cltbld', 09:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:27 INFO - 'MOZ_NO_REMOTE': '1', 09:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:27 INFO - 'NO_EM_RESTART': '1', 09:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:27 INFO - 'PWD': '/builds/slave/test', 09:23:27 INFO - 'SHELL': '/bin/bash', 09:23:27 INFO - 'SHLVL': '1', 09:23:27 INFO - 'TERM': 'linux', 09:23:27 INFO - 'TMOUT': '86400', 09:23:27 INFO - 'USER': 'cltbld', 09:23:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:27 INFO - '_': '/tools/buildbot/bin/python'} 09:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:27 INFO - Cleaning up... 09:23:27 INFO - Return code: 0 09:23:27 INFO - Running post-action listener: _resource_record_post_action 09:23:27 INFO - Running post-action listener: _start_resource_monitoring 09:23:27 INFO - Starting resource monitoring. 09:23:27 INFO - [mozharness: 2017-05-12 16:23:27.382043Z] Finished create-virtualenv step (success) 09:23:27 INFO - [mozharness: 2017-05-12 16:23:27.382498Z] Running install step. 09:23:27 INFO - Running pre-action listener: _resource_record_pre_action 09:23:27 INFO - Running main action method: install 09:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:27 INFO - Reading from file tmpfile_stdout 09:23:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:27 INFO - Reading from file tmpfile_stdout 09:23:27 INFO - Output received: 09:23:27 INFO - Usage: mozinstall [options] installer 09:23:27 INFO - Options: 09:23:27 INFO - -h, --help show this help message and exit 09:23:27 INFO - -d DEST, --destination=DEST 09:23:27 INFO - Directory to install application into. [default: 09:23:27 INFO - "/builds/slave/test"] 09:23:27 INFO - --app=APP Application being installed. [default: firefox] 09:23:27 INFO - mkdir: /builds/slave/test/build/application 09:23:27 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'] 09:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:23:43 INFO - Reading from file tmpfile_stdout 09:23:43 INFO - Output received: 09:23:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:23:43 INFO - Running post-action listener: _resource_record_post_action 09:23:43 INFO - [mozharness: 2017-05-12 16:23:43.541827Z] Finished install step (success) 09:23:43 INFO - [mozharness: 2017-05-12 16:23:43.542073Z] Running run-tests step. 09:23:43 INFO - Running pre-action listener: _resource_record_pre_action 09:23:43 INFO - Running main action method: run_tests 09:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:23:43 INFO - Python 2.7.3 09:23:43 INFO - Return code: 0 09:23:43 INFO - grabbing minidump binary from tooltool 09:23:43 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')]} 09:23:43 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 0x1d20a30>, '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 0x1d217f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d21ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:23:43 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 09:23:43 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 09:23:43 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 09:23:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:43 INFO - Return code: 0 09:23:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:23:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:23:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:23:43 INFO - ENV: RUST_BACKTRACE is now 1 09:23:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:23:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:23:43 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/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 09:23:43 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/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 09:23:43 INFO - Using env: {'DISPLAY': ':0', 09:23:43 INFO - 'HOME': '/home/cltbld', 09:23:43 INFO - 'LANG': 'en_US.UTF-8', 09:23:43 INFO - 'LANGUAGE': 'en_US:en', 09:23:43 INFO - 'LOGNAME': 'cltbld', 09:23:43 INFO - 'MAIL': '/var/mail/cltbld', 09:23:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:23:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:43 INFO - 'MOZ_NO_REMOTE': '1', 09:23:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:43 INFO - 'NO_EM_RESTART': '1', 09:23:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:43 INFO - 'PWD': '/builds/slave/test', 09:23:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:23:43 INFO - 'RUST_BACKTRACE': '1', 09:23:43 INFO - 'SHELL': '/bin/bash', 09:23:43 INFO - 'SHLVL': '1', 09:23:43 INFO - 'TERM': 'linux', 09:23:43 INFO - 'TMOUT': '86400', 09:23:43 INFO - 'USER': 'cltbld', 09:23:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013', 09:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:43 INFO - '_': '/tools/buildbot/bin/python'} 09:23:43 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/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 09:23:44 INFO - mozversion application_buildid: 20170512154902 09:23:44 INFO - mozversion application_changeset: 1e2fe13035e13b7b4001ade3b48f226957cef5fc 09:23:44 INFO - mozversion application_display_name: Nightly 09:23:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:44 INFO - mozversion application_name: Firefox 09:23:44 INFO - mozversion application_remotingname: firefox 09:23:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:23:44 INFO - mozversion application_vendor: Mozilla 09:23:44 INFO - mozversion application_version: 55.0a1 09:23:44 INFO - mozversion platform_buildid: 20170512154902 09:23:44 INFO - mozversion platform_changeset: 1e2fe13035e13b7b4001ade3b48f226957cef5fc 09:23:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:23:44 INFO - mozversion platform_version: 55.0a1 09:23:44 INFO - using testdate: 1494606224 09:23:44 INFO - actual date: 1494606224 09:23:44 INFO - starting webserver on 'localhost:45416' 09:23:44 INFO - SUITE-START | Running 2 tests 09:23:44 INFO - TEST-START | dromaeo_css 09:23:44 INFO - operating with platform_type : linux_ 09:23:44 INFO - Initialising browser for dromaeo_css test... 09:23:44 INFO - TEST-INFO | started process 3307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4mPDnr/profile http://localhost:45416/getInfo.html) 09:23:49 INFO - PID 3307 | __metrics Screen width/height:1600/1200 09:23:49 INFO - PID 3307 | colorDepth:24 09:23:49 INFO - PID 3307 | Browser inner width/height: 1024/695 09:23:49 INFO - PID 3307 | __metrics 09:23:51 INFO - TEST-INFO | 3307: exit 0 09:23:51 INFO - Browser initialized. 09:23:51 INFO - Running cycle 1/1 for dromaeo_css test... 09:23:51 INFO - TEST-INFO | started process 3479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4mPDnr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:03 INFO - PID 3479 | RSS: Main: 156336128 09:24:03 INFO - PID 3479 | 09:27:09 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45416/tests/dromaeo/cssquery-ext.html) 09:27:11 INFO - PID 3479 | RSS: Main: 167690240 09:27:11 INFO - PID 3479 | 09:30:13 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-ext.html (next: http://localhost:45416/tests/dromaeo/cssquery-jquery.html) 09:30:13 INFO - PID 3479 | RSS: Main: 162295808 09:30:13 INFO - PID 3479 | 09:33:15 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45416/tests/dromaeo/cssquery-mootools.html) 09:33:16 INFO - PID 3479 | RSS: Main: 168837120 09:33:16 INFO - PID 3479 | 09:36:17 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45416/tests/dromaeo/cssquery-prototype.html) 09:36:18 INFO - PID 3479 | RSS: Main: 161832960 09:36:18 INFO - PID 3479 | 09:39:21 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45416/tests/dromaeo/cssquery-yui.html) 09:39:22 INFO - PID 3479 | RSS: Main: 166137856 09:39:22 INFO - PID 3479 | 09:42:23 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-yui.html (next: http://localhost:45416/tests/dromaeo/cssquery-dojo.html) 09:42:24 INFO - PID 3479 | RSS: Main: 168574976 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | __start_tp_report 09:42:24 INFO - PID 3479 | _x_x_mozilla_page_load 09:42:24 INFO - PID 3479 | _x_x_mozilla_page_load_details 09:42:24 INFO - PID 3479 | |i|pagename|runs| 09:42:24 INFO - PID 3479 | |0;dojo.html;2735.042735042734;2755.738204870537;2762.557990721485;2777.6389069420984;2778.0832325332644;5234.842954711356;5241.2924255225535;5265.842024739264;5273.5781137509;5305.628605997582;5322.175062865253;5327.547158491523;5328.973355133219;5414.648047876885;5454;4425.645948324126;4673.88315292117;4736.242201247801;4769.689970151946;4792.04159168166;4780.617550595944;4825.493323201066;4833.927491087637;4838.5887199587905;4858.052679727454;4695.131400690849;4732.787024583902;4748.3114948332295;4785.760711964388;4793.18515852306;4751.168545504557;4774.928376074362;4777.044591081798;4820.204666230068;4837.129316722989;4675.251959686434;4679.906401871977;4707.270373092142;4751.287306903958;4754.072955773626;5265.921011184835;5321.600879933982;5341.759620817073;5343.198520221959;5385.7307134643115;5723.112917497794;5790.623609465371;5816.47651711348;5821.88356232873;5832.270966129234;5854.560907931879;5868;5868.295804503444;5869.413058694139;5881.823545293648;5309.123994540934;5431.103867861838;5440.99999999996;5447.809326673548;5450.8909821803345;5930.851728706817;5946.672932988728;6019.729112189962;6037.78867739627;6080.817575472743;5562.3881373048935;5650.5479561634975;5659.207710920475;5726.169705392695;5784.623999440023;5835.94164058354;5869.471747542656;5876.764929402776;5886.23478947734;5939.851503712442;5806.709664516758;5808.651480911159;5811.767529298781;5823.88352232953;5831.212786273799;5585.357683866326;5654.802081927113;5666.206731057655;5768.077107662753;5786.04530252512;4923.08922849274;4930.063287975273;4930.433000205022;4930.7288099154175;4947.084789313988;4183.958160418418;4193.161367726467;4199.454070970754;4217.219814334358;4228.090960443519;4863.805447782049;4917.28699338601;4924.852254432372;4925.605951523869;4991.925121123186;5758.049921762946;5775.48020678141;5777.711114444261;5780;5834.329052159056;4928.236123400807;4953.950460495349;4960.156773348467;4966.627502937295;4973.254011898244;5169.4830516948;5184.170532714747;5201.427842937273;5206.739663016834;5208.739563021833;5314.5216930476445;5327.467253274564;5337.8131765388025;5358.490943360374;5360.839174824761;5804.21643078179;5828.94171058301;5840.99999999983;5847.210626565529;5855.180274761622;5344.75948582307;5346.919796203138;5366.248725178556;5373.946260537501;5401.594880384066;5745.827625171251;5776.277965254343;5790.739416726173;5795.884082318415;5807.390224026585;5714;5777.046787280052;5872.324682661549;5903.409659034062;5914.940850591611;5603.943960560342;5629.831105066854;5684.8294551163535;5698.686572238401;5725.398833122462;5677.943220567907;5686.2607860977805;5700.116481945305;5701.97364474382;5703.543716502587;5506.339239291311;5540.584456165723;5575.219469274386;5576.052071147996;5590.245316882331;5582.190582365453;5642.717864106696;5643.746031428514;5665.065264231355;5726.455986681259;5434.184872269191;5515.951969125853;5518.503334699896;5518.80684176068;5519.641223320471 09:42:24 INFO - PID 3479 | |1;ext.html;647.1005302629343;691.4192078653931;712.7469748239373;1135.1656532448649;1194.2595590733736;33475.330493390116;34110.48834267488;34173.82913085437;34193;34316.48525272123;31835;32115.67884321156;32173.51739723906;32205.838970805115;32209.83895080527;6481.999999999988;6553.5740176888585;6588.3411658833975;6676.833079173035;6915.066466027072;6907.827304317382;6991.965040174792;6993.82515437113;6999.160100787913;7008.264132266115;6894.379505844473;6989.720411183546;6995.02069710241;7002.299770023008;7014;6908.550944188662;6914.06660100885;6957.269486703899;6961.721531138748;7000.64996750163;6802.897956530656;6845.212800527953;6853.691583878687;6873.140857392826;6876.828079298008;29954;30083.849580752176;30163.0951071466;30220.395592088036;30299;2961.481740695391;2973.8810447582073;2994.2215024093894;2996.3258266889775;3018.2152640313457;23616;23804;23809.404764880845;23919.402014949592;23927.28218153458;3112.393083348748;3139.9058028259187;3146.6381366142728;3176.190071531768;3180.125465496984;114634;115801.42099289534;133569;134219;134862.3256883719;36267.63732362695;37244.81377593149;37311.626883731355;37436.812815935744;37469.62530374716;38802;39074.804625976685;39139;39156.412653810214;39210;11210.719732006764;11241.437928103562;11327.037201837937;11331.376774277494;11347.092232621535;9063.410878293022;9063.54682265884;9123.635054597875;9137.954310228406;9139.588718507683;11627.59303424376;11644.2431241969;11802.701702812683;11837.408129593487;11915.523379064914;4976.377952755905;5075.822346217865;5119.129747942859;5122.1804511278015;5176.120059589879;869.7390782765145;909.7634615000147;910.8451563234266;912.1995473895079;934.0892629686002;20113.798862011485;21201.681974770392;21249.256276030574;21326.88932313049;21395.893020534797;969.6557722008727;982.1062832822098;1009.6466236817203;1011.9696409107738;1017.1252722658508;10833.241673082808;11311.773764524663;13910.513132040533;14519;14587.416503339748;147556;149405.2529737366;150674;150983;151710;42153.36769948453;42545.787271064066;42624.57375426268;42726.57273427288;42896.57103428988;1212.4604550974907;1248.494359784289;1252.511520507003;1256.064232147038;1256.2901960392533;23672;23974;24844.627330590418;24961.50076998486;24985.500289993735;29782;29898.85050574733;30117.247068823453;30172.54741178928;30208.848955755082;146700.2664986711;146932;147007;147515.26242369149;147601;27881.86059069773;28536;28755.568666470437;29534.409311814074;29547.261318467212;35088.47367289442;35312.47031294481;35387;35413.29173416569;35449.46825797667;25449.236522904343;26271.211863643355;26554.867225663747;27453.17640470789;27518;26547.336316591467;26720.732792672603;27132.457350853267;27344;28088.578671319538;30081;30451;30741.692583073884;30780.53829192519;30818.53772193374;25141.371465713502;26856.462870742867;26985.595216072168;27079;27416.58875116835;20478.897605511876;22018;22028.229011984502;22202.777972220716;22375.216867409563 09:42:24 INFO - PID 3479 | |2;jquery.html;421.38267438203025;431.3092676707307;431.9676024298178;444.1871375383049;449.9482559505658;16867.73491988101;17011;17833.732494012602;17852.64294714108;17986.100694965247;18056.368027119053;18282;19179.32872349468;19346.806531934675;19409.708854367196;5444.591655625824;5502.8349149525475;5581.107022876341;5596.720163991805;5613;5522.6134170607875;5679.630823996447;5689.146628005811;5690.630109042899;5698;5451.727413629323;5563.193336966137;5580;5613.550915926737;5620.634658747189;5430.348358197002;5556.666600003992;5566.165075238706;5597.776088956437;5597.944020559783;5012.8997420051755;5029.19532874742;5031.471695471996;5065.898682026375;5067.391912970467;21919.12323507058;22200.555988880293;22297.44256393587;22362.10551577935;22370.32889013332;1666.475060355984;1694.5509439998286;1700.8214137515631;1706.4965835078558;1714.0572685023187;14705.632359191106;14773.704525909421;14890.106593604418;15079.849201508065;15228.771568426482;2046.5190680190144;2049.5695903860205;2108.3674897530677;2112.0495776900457;2135.9145634174615;81052;81796;81992.59003705003;82107.5894620529;83404.16595834025;11244.550217991353;11315.321080735182;11345;11484.368359740127;11501.137414693763;15686.76469852953;15850.128242946748;15869.68260634781;15902.284397202153;15948.521544353687;7583.27958843909;7697.4226932980255;7730.961345193238;7871.33093687043;7889.17163697815;6967.721291148398;7034.648267586703;7048.823779405556;7201;7231.566106033655;7068.611226382598;7080.973258877434;7151.2491188424465;7215.783526494213;7337.376323012497;2102.35878057191;2114.524232047777;2130.3076500137518;2168.371172359998;2185.89070546472;844.273924424994;878.2447095497866;879.6261588824724;887.2059506741431;905.8414777413926;17073.7438938416;17411.303547857944;17707;18017.54956126081;18158.45524634263;864.9697260595849;870.2602787630464;882.43965082172;883.5979629268668;901.8421776189272;9430.62277508892;9767.316287859923;9866.753331166778;9867.851982220272;9999.450030248407;321797;334896;335516;337477;341812;73203.63398182976;74908.25091749121;76089.23910760932;76103.61948190223;78342.60828695934;946.1248345280588;973.8003709239589;978.0659470205936;981.215027977615;1041.317936751429;16067;16645.83354166443;16812.747808783122;17609.735853961945;17706.91146544259;40128;40520.04658625653;40621;40621.390679139244;40854;47254.527454725016;48841.26738099002;49297.753511232215;51490;51672.741636291576;7848.372130229453;8039;8055.516668999879;8244.587770611566;8407.663693452194;12896.161749486253;13215.207087574776;13294.40175192138;13303.135296206103;13465.124766890121;10832.458377080957;11097.944510277397;11133.830947750694;11392.772144556897;11538.076953843505;10160.695179144637;10558.472076395996;10603.734906627396;10624.521896514521;10635.787284254116;11382.829257561309;11386.316820990767;11471.254368466023;11702.590409335633;11873;7953.125156232925;8021.197880211932;8048.476849004796;8177.550234737147;8254.215849494289;10133.543990520297;10198.796024079626;10395.116415104801;10493.317934334244;10548.103411209826 09:42:24 INFO - PID 3479 | |3;mootools.html;1261.432355440052;1308.3719814489045;1312.1405479410978;1314.08014389927;1335.5726167626358;10172.949135254323;10490.947545262263;10670.199735019876;10670.78658426831;10851.186161037935;10535.789284214312;10708;10710.357378557272;10716.196285278616;10722.463876806167;2170.8480406371523;2203.46015226269;2205.6691496275607;2213.811825994784;2228.2312602152233;2248.0782879019607;2279.4985103277254;2283.5547068321684;2288.9198878039274;2291.7249930008425;2253.4479052632128;2265.954680906389;2289.0843662534953;2292.6561015847587;2300.424893776556;2184.497565559914;2213.568354170929;2217.6008318502663;2217.8225741940687;2221.1559607349263;2085.718428012214;2228.220122956968;2233.050953344822;2234.084025549517;2237.832162587796;10392.428416437093;10509.632162874263;10516.421596812172;10518.684439466828;10526.842097368546;5589.608727389084;5861.85345366365;5866.501347385477;5867.559933004999;5871.089981052901;3289.1612638777196;3291.5062740588864;3316.137804170909;3454.896353109411;3545.1137215696076;1043.3844032021143;1062.0176336888424;1094.3379255550358;1100.3452945497415;1107.147496427746;14660.047096938664;14726.042807217496;14785.112893226333;14793.408263669333;14829.703405931929;4766.904661906812;4898.657094003385;5011.774470148852;5054.595632349403;5074.873128171751;10918.617848375268;10966.506507207196;11002.119830413547;11013.559457621766;11061.834072488919;5577.358603760538;5629.240052592848;5634.549236061105;5643.548516118783;5647.661140331593;4970.826021089245;5195.818146364859;5289.920651190235;5321.574274058144;5368.114261146867;3831.63599458051;3952.6047395260243;3997.800109994547;4062.918741625151;4077.4699289092823;1077.3966578715945;1085.6146068145695;1105.5577768892347;1109.040679811973;1111.9833202501968;655.9704813283414;677.7119724117231;686.7115811359241;705.1115594351154;705.1291654806311;5313.601479889024;5692.23154874095;5958.314793798769;6048.032314829694;6134.938650613437;540.7269328988835;562.971851407428;564.0833645326345;564.6894208185481;566.6711561388537;3343.1474973881504;3384.1032126486502;3697.5378077740284;3713.814309284525;3864.30442520349;12895.806562901564;13558.050936434354;13594.524191653245;13617.659558510919;13628.795568066487;13403.061785675105;13410.195388276734;13432.932835335956;13440.596782096552;13463.259520726258;7410.592417417094;7799.961000194962;7816.179301173409;7828.647710853025;7844.097928738268;5911.379305172895;6079.939200607937;6157.722902469489;6226.750929962751;6352.237731472068;12194.878051219373;12273.263604183778;12348.259104453402;12530.37348132608;12537.373131343578;12448;12456.252624842538;12567.120301579167;12622.621321360373;12810.871891280967;7736.342410894912;7902.367810575255;7950.9266249057955;7987.440879138405;8008.639611217625;8814.162654547808;8886.777830554287;8951;8956.193942545202;8976.326775491734;7486.962565187139;7665.961670191613;7685.346745526693;7910;8089.87865182011;7926.762197134095;8000.599970001593;8026.197380261927;8031.919680803117;8096.190380962093;7302.5253358533655;7403.259674032553;7435.591042492715;7452.739154129579;7457.067866516685;5358.383785864676;5392.676439413648;5407.459254074561;5462.972685136708;5669.688167150846;5140.537351638371;5173.922391164211;5208.583313335;5223.843284701465;5388.380336261223 09:42:24 INFO - PID 3479 | |4;prototype.html;378.2756022217454;398.4421809466747;404.5226632573562;404.6095517825299;409.35730902483095;5385.703786291752;5581.046633678211;5602.24369710089;5676.602637815355;5683.744231509581;5362.705051222181;5499.587530935186;5534.778608855641;5539.778408863641;5544.362398324194;4376.868693939179;4382.627476664487;4388.912221755563;4393.890152746191;4402.1195760847795;4286.699931004831;4345.869623911272;4385.714928529651;4394.47266328041;4402.713823601472;4340;4340.500842403117;4340.913181736363;4342.826286948534;4352.912941741163;4339.218940590692;4353.695241333108;4358.8474403395885;4360.345948107777;4362.629176519999;3866.072142685763;3946;3978.1446988897237;3980.383040628707;3981.28336899358;5399.2980912481125;5432.837014889559;5457.536109430703;5462.781488740446;5503.862403439906;5186.351706036746;5205.739713014372;5209.400918894337;5210.244514545369;5226.55574276187;5740.225069615591;5852.766803354457;5864.472197502203;5921.526277897758;5928.547505861092;4438.755868427235;4468.128714900596;4471.28459446487;4472.1502914446155;4487.887802804956;5994.220751302303;6158.784442544535;6174.135621013017;6196.87606247877;6211.285702144266;4150.8547200847825;4178.6657067434535;4179.540250572434;4183.100633363781;4187.120704652058;4184.476940382452;4207.4951005878875;4232.026633874226;4237.576242375738;4241.215375155606;4753.83361582343;4791.904161916742;4862.294967229732;4881.9511804881495;4886.755662216875;5829.213056237439;5847.585073269739;5849.61977471463;5849.853753656193;5859.736311865976;1443.1773888883445;1449.681070164562;1461.751502244621;1465.1136062682137;1473.2118316700514;974.4348277998744;977.7555611097225;980.2158273381267;987.2546227598117;998.1964518562627;5097.1844504879045;5119.744012799345;5124.897502049938;5131.7177555234075;5165.354330708661;5991.4907232884825;6045.183900173508;6061.636301821904;6098.1157732128595;6143.201383820075;4999.875003124951;5076.6953982760415;5084.652622008203;5105;5179.792808287626;3189.186757376854;3249.985009294253;3250.658680838525;3258.837058147083;3261.4781634938295;5499.020352673035;5573;5594.944050559524;5605.150300400858;5608.270924779753;6179.721912513947;6201.782937597162;6205.2553693557065;6216.7824126155365;6251.468625166821;5616.578756593353;5616.9608622404985;5618.129189975561;5622.493975542221;5632.7746890123935;5990.371011043778;6024.33732289439;6024.969875150597;6075.665838378932;6151.292601350902;5857.502112320501;5999.560325359115;6005.789797357072;6035.9094613579955;6051.425114614105;5616.971915140398;5635.746391412315;5642.915356269741;5647.644565304216;5659.340110148224;4144.917101657889;4182.937255941102;4196.160767846504;4200.012996945777;4204.264253755642;6010.398960103955;6127.264728232641;6156.78451254204;6178.281556115295;6205.81382558524;5925.318588362394;5931.851703707442;5936.436038576328;5944.019236825875;5949.881002380015;5795.884082318415;5913.70431478433;5947.9702601486715;5956.821295361146;5959.95700752358;5755.223044889054;5794.594378393472;5803.419658034163;5821.214136091573;5831.241938547962;5930.466258036798;5957.076653118774;5957.863400697289;5964.433378829004;5984.491318237999;5600.679592840345;5663.886722265449;5723.227364305932;5759.0209664356325;5761.971190144022 09:42:24 INFO - PID 3479 | |5;yui.html;619.4486906653079;619.9876002479954;679.9558028728133;680.3400701319719;693.7675878580675;12278.877211227886;12624.305663188521;12927.09510334277;12956.416961236744;13332.533361332355;15434.151121688303;15674.608134796606;15694.843051569482;16012.19939003051;16050.27773750181;887.9378443508957;908.0964440381796;909.4043401571981;911.6399022386187;917.7843206846386;862;899.4917871402637;908.504864848659;908.9136532029447;910.0808183734442;951.8239125761756;953.3136141977765;953.9570719317647;954.5990683912738;955.5604421965869;946.7633091727068;947.5593848860278;948.1750876737214;949.4208532794989;950.4487397309543;697.3584302441766;698.4447364345358;701.6737217194029;703.2791388826442;705.8800003999332;12707.809382859172;12934.741305173939;13116.737665246641;13213.73572528544;13580.728385432334;15864.92067539655;15868.603284917854;16161.272742726605;16277.674446511122;16337.83662163375;11035.668929932115;11186.832197517044;11206.383648899307;11216.495257713423;11268.436578171058;2947.3221159133304;2997.6252968378953;3012.0813151988636;3014.095771268611;3016.8039077460116;67978.3202167982;68341.65829170872;68646;69825;70229.2977070228;11797.823032654516;12015.879841201651;12082.093842961638;12268.141230113984;12276.815847762291;20094.19623215055;20557.486062848548;21906.561868762536;22001.449963751034;22095.226667066574;6024.668643224665;6027.36712645166;6097.847553811191;6150;6220.875582488325;2912.7378535931443;2925.414917016605;2954.896578619738;2983.030515082607;2997.2806526433933;3460.8615655374006;3512.13952581614;3552.626974167727;3556.3776339140545;3731.6268373162466;763.9083310002835;774.4578794843632;781.4725060584083;783.7805414483954;786.7679034684782;584.5206930317185;606.5663050918614;607.5959486941134;613.6287546034584;622.6637615687478;8992.759051186018;9744.269179811543;10025.298229124037;10243;10555.26113172086;585.1778251556569;590.9497692696083;596.2189531713469;599.7391134856351;608.8417011576934;4472.843450479218;4572.977135114304;4606.585407313358;4638.768061596907;4640.86077417678;60608;60844;61210.69394652998;62350.37649623537;62866;53829.46170538245;54741.452585474435;55165;55274.17088743672;55652.44347556554;48369.27446088311;48950.75524622354;50098.749506252236;50380.244296335586;50795.23807142896;9164.95417522908;9205.76985575366;9266.860997085185;9351.953240233755;9660.130588247092;26214.019336326037;26749.732502674724;27276.181714548595;27313.726862731117;27705.86147069252;32071.839640801645;32226;32358.83820580882;33112.50331245081;33132.66867331392;11626.360550169822;11862.525498979945;11908.285502869856;11991.460384282555;12102.092343074128;11904.702382440508;11929.940350298193;12048.337341446304;12166.209196402206;12272.877271227173;11384.48769805344;11458.598949036743;11496.195266331611;11511.654650360502;11598.18812683138;11369.772604547697;11592;11618.535258589562;13723.794143088062;14500.637484062983;12876.163049401759;13209.537666181637;13777.828884544926;14029.859701402855;14294.070885392832;10909.127269818555;10979.341239525655;11114.388708621103;11177.105831533296;11452.484638191134;10548.314359566604;11216.864002223165;11237.3257604544;11343.376114313793;11449.198556100993 09:42:24 INFO - PID 3479 | __end_tp_report 09:42:24 INFO - PID 3479 | __start_cc_report 09:42:24 INFO - PID 3479 | _x_x_mozilla_cycle_collect,375 09:42:24 INFO - PID 3479 | __end_cc_report 09:42:24 INFO - PID 3479 | __startTimestamp1494607344047__endTimestamp 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | ------- Summary: start ------- 09:42:24 INFO - PID 3479 | Number of tests: 6 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | [#0] dojo.html Cycles:165 Average:5299.21 Median:5441.00 stddev:633.92 (11.7%) stddev-sans-first:603.10 09:42:24 INFO - PID 3479 | Values: 2735.0 2755.7 2762.6 2777.6 2778.1 5234.8 5241.3 5265.8 5273.6 5305.6 5322.2 5327.5 5329.0 5414.6 5454.0 4425.6 4673.9 4736.2 4769.7 4792.0 4780.6 4825.5 4833.9 4838.6 4858.1 4695.1 4732.8 4748.3 4785.8 4793.2 4751.2 4774.9 4777.0 4820.2 4837.1 4675.3 4679.9 4707.3 4751.3 4754.1 5265.9 5321.6 5341.8 5343.2 5385.7 5723.1 5790.6 5816.5 5821.9 5832.3 5854.6 5868.0 5868.3 5869.4 5881.8 5309.1 5431.1 5441.0 5447.8 5450.9 5930.9 5946.7 6019.7 6037.8 6080.8 5562.4 5650.5 5659.2 5726.2 5784.6 5835.9 5869.5 5876.8 5886.2 5939.9 5806.7 5808.7 5811.8 5823.9 5831.2 5585.4 5654.8 5666.2 5768.1 5786.0 4923.1 4930.1 4930.4 4930.7 4947.1 4184.0 4193.2 4199.5 4217.2 4228.1 4863.8 4917.3 4924.9 4925.6 4991.9 5758.0 5775.5 5777.7 5780.0 5834.3 4928.2 4954.0 4960.2 4966.6 4973.3 5169.5 5184.2 5201.4 5206.7 5208.7 5314.5 5327.5 5337.8 5358.5 5360.8 5804.2 5828.9 5841.0 5847.2 5855.2 5344.8 5346.9 5366.2 5373.9 5401.6 5745.8 5776.3 5790.7 5795.9 5807.4 5714.0 5777.0 5872.3 5903.4 5914.9 5603.9 5629.8 5684.8 5698.7 5725.4 5677.9 5686.3 5700.1 5702.0 5703.5 5506.3 5540.6 5575.2 5576.1 5590.2 5582.2 5642.7 5643.7 5665.1 5726.5 5434.2 5516.0 5518.5 5518.8 5519.6 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | [#1] ext.html Cycles:180 Average:28619.24 Median:30167.82 stddev:36465.09 (120.9%) stddev-sans-first:36506.88 09:42:24 INFO - PID 3479 | Values: 647.1 691.4 712.7 1135.2 1194.3 33475.3 34110.5 34173.8 34193.0 34316.5 31835.0 32115.7 32173.5 32205.8 32209.8 6482.0 6553.6 6588.3 6676.8 6915.1 6907.8 6992.0 6993.8 6999.2 7008.3 6894.4 6989.7 6995.0 7002.3 7014.0 6908.6 6914.1 6957.3 6961.7 7000.6 6802.9 6845.2 6853.7 6873.1 6876.8 29954.0 30083.8 30163.1 30220.4 30299.0 2961.5 2973.9 2994.2 2996.3 3018.2 23616.0 23804.0 23809.4 23919.4 23927.3 3112.4 3139.9 3146.6 3176.2 3180.1 114634.0 115801.4 133569.0 134219.0 134862.3 36267.6 37244.8 37311.6 37436.8 37469.6 38802.0 39074.8 39139.0 39156.4 39210.0 11210.7 11241.4 11327.0 11331.4 11347.1 9063.4 9063.5 9123.6 9138.0 9139.6 11627.6 11644.2 11802.7 11837.4 11915.5 4976.4 5075.8 5119.1 5122.2 5176.1 869.7 909.8 910.8 912.2 934.1 20113.8 21201.7 21249.3 21326.9 21395.9 969.7 982.1 1009.6 1012.0 1017.1 10833.2 11311.8 13910.5 14519.0 14587.4 147556.0 149405.3 150674.0 150983.0 151710.0 42153.4 42545.8 42624.6 42726.6 42896.6 1212.5 1248.5 1252.5 1256.1 1256.3 23672.0 23974.0 24844.6 24961.5 24985.5 29782.0 29898.9 30117.2 30172.5 30208.8 146700.3 146932.0 147007.0 147515.3 147601.0 27881.9 28536.0 28755.6 29534.4 29547.3 35088.5 35312.5 35387.0 35413.3 35449.5 25449.2 26271.2 26554.9 27453.2 27518.0 26547.3 26720.7 27132.5 27344.0 28088.6 30081.0 30451.0 30741.7 30780.5 30818.5 25141.4 26856.5 26985.6 27079.0 27416.6 20478.9 22018.0 22028.2 22202.8 22375.2 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | [#2] jquery.html Cycles:180 Average:23864.31 Median:20637.69 stddev:55797.59 (270.4%) stddev-sans-first:55926.36 09:42:24 INFO - PID 3479 | Values: 421.4 431.3 432.0 444.2 449.9 16867.7 17011.0 17833.7 17852.6 17986.1 18056.4 18282.0 19179.3 19346.8 19409.7 5444.6 5502.8 5581.1 5596.7 5613.0 5522.6 5679.6 5689.1 5690.6 5698.0 5451.7 5563.2 5580.0 5613.6 5620.6 5430.3 5556.7 5566.2 5597.8 5597.9 5012.9 5029.2 5031.5 5065.9 5067.4 21919.1 22200.6 22297.4 22362.1 22370.3 1666.5 1694.6 1700.8 1706.5 1714.1 14705.6 14773.7 14890.1 15079.8 15228.8 2046.5 2049.6 2108.4 2112.0 2135.9 81052.0 81796.0 81992.6 82107.6 83404.2 11244.6 11315.3 11345.0 11484.4 11501.1 15686.8 15850.1 15869.7 15902.3 15948.5 7583.3 7697.4 7731.0 7871.3 7889.2 6967.7 7034.6 7048.8 7201.0 7231.6 7068.6 7081.0 7151.2 7215.8 7337.4 2102.4 2114.5 2130.3 2168.4 2185.9 844.3 878.2 879.6 887.2 905.8 17073.7 17411.3 17707.0 18017.5 18158.5 865.0 870.3 882.4 883.6 901.8 9430.6 9767.3 9866.8 9867.9 9999.5 321797.0 334896.0 335516.0 337477.0 341812.0 73203.6 74908.3 76089.2 76103.6 78342.6 946.1 973.8 978.1 981.2 1041.3 16067.0 16645.8 16812.7 17609.7 17706.9 40128.0 40520.0 40621.0 40621.4 40854.0 47254.5 48841.3 49297.8 51490.0 51672.7 7848.4 8039.0 8055.5 8244.6 8407.7 12896.2 13215.2 13294.4 13303.1 13465.1 10832.5 11097.9 11133.8 11392.8 11538.1 10160.7 10558.5 10603.7 10624.5 10635.8 11382.8 11386.3 11471.3 11702.6 11873.0 7953.1 8021.2 8048.5 8177.6 8254.2 10133.5 10198.8 10395.1 10493.3 10548.1 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | [#3] mootools.html Cycles:180 Average:6340.87 Median:3500.01 stddev:4089.00 (116.8%) stddev-sans-first:4082.66 09:42:24 INFO - PID 3479 | Values: 1261.4 1308.4 1312.1 1314.1 1335.6 10172.9 10490.9 10670.2 10670.8 10851.2 10535.8 10708.0 10710.4 10716.2 10722.5 2170.8 2203.5 2205.7 2213.8 2228.2 2248.1 2279.5 2283.6 2288.9 2291.7 2253.4 2266.0 2289.1 2292.7 2300.4 2184.5 2213.6 2217.6 2217.8 2221.2 2085.7 2228.2 2233.1 2234.1 2237.8 10392.4 10509.6 10516.4 10518.7 10526.8 5589.6 5861.9 5866.5 5867.6 5871.1 3289.2 3291.5 3316.1 3454.9 3545.1 1043.4 1062.0 1094.3 1100.3 1107.1 14660.0 14726.0 14785.1 14793.4 14829.7 4766.9 4898.7 5011.8 5054.6 5074.9 10918.6 10966.5 11002.1 11013.6 11061.8 5577.4 5629.2 5634.5 5643.5 5647.7 4970.8 5195.8 5289.9 5321.6 5368.1 3831.6 3952.6 3997.8 4062.9 4077.5 1077.4 1085.6 1105.6 1109.0 1112.0 656.0 677.7 686.7 705.1 705.1 5313.6 5692.2 5958.3 6048.0 6134.9 540.7 563.0 564.1 564.7 566.7 3343.1 3384.1 3697.5 3713.8 3864.3 12895.8 13558.1 13594.5 13617.7 13628.8 13403.1 13410.2 13432.9 13440.6 13463.3 7410.6 7800.0 7816.2 7828.6 7844.1 5911.4 6079.9 6157.7 6226.8 6352.2 12194.9 12273.3 12348.3 12530.4 12537.4 12448.0 12456.3 12567.1 12622.6 12810.9 7736.3 7902.4 7950.9 7987.4 8008.6 8814.2 8886.8 8951.0 8956.2 8976.3 7487.0 7666.0 7685.3 7910.0 8089.9 7926.8 8000.6 8026.2 8031.9 8096.2 7302.5 7403.3 7435.6 7452.7 7457.1 5358.4 5392.7 5407.5 5463.0 5669.7 5140.5 5173.9 5208.6 5223.8 5388.4 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | [#4] prototype.html Cycles:180 Average:4883.14 Median:5542.07 stddev:1418.33 (25.6%) stddev-sans-first:1381.42 09:42:24 INFO - PID 3479 | Values: 378.3 398.4 404.5 404.6 409.4 5385.7 5581.0 5602.2 5676.6 5683.7 5362.7 5499.6 5534.8 5539.8 5544.4 4376.9 4382.6 4388.9 4393.9 4402.1 4286.7 4345.9 4385.7 4394.5 4402.7 4340.0 4340.5 4340.9 4342.8 4352.9 4339.2 4353.7 4358.8 4360.3 4362.6 3866.1 3946.0 3978.1 3980.4 3981.3 5399.3 5432.8 5457.5 5462.8 5503.9 5186.4 5205.7 5209.4 5210.2 5226.6 5740.2 5852.8 5864.5 5921.5 5928.5 4438.8 4468.1 4471.3 4472.2 4487.9 5994.2 6158.8 6174.1 6196.9 6211.3 4150.9 4178.7 4179.5 4183.1 4187.1 4184.5 4207.5 4232.0 4237.6 4241.2 4753.8 4791.9 4862.3 4882.0 4886.8 5829.2 5847.6 5849.6 5849.9 5859.7 1443.2 1449.7 1461.8 1465.1 1473.2 974.4 977.8 980.2 987.3 998.2 5097.2 5119.7 5124.9 5131.7 5165.4 5991.5 6045.2 6061.6 6098.1 6143.2 4999.9 5076.7 5084.7 5105.0 5179.8 3189.2 3250.0 3250.7 3258.8 3261.5 5499.0 5573.0 5594.9 5605.2 5608.3 6179.7 6201.8 6205.3 6216.8 6251.5 5616.6 5617.0 5618.1 5622.5 5632.8 5990.4 6024.3 6025.0 6075.7 6151.3 5857.5 5999.6 6005.8 6035.9 6051.4 5617.0 5635.7 5642.9 5647.6 5659.3 4144.9 4182.9 4196.2 4200.0 4204.3 6010.4 6127.3 6156.8 6178.3 6205.8 5925.3 5931.9 5936.4 5944.0 5949.9 5795.9 5913.7 5948.0 5956.8 5960.0 5755.2 5794.6 5803.4 5821.2 5831.2 5930.5 5957.1 5957.9 5964.4 5984.5 5600.7 5663.9 5723.2 5759.0 5762.0 09:42:24 INFO - PID 3479 | 09:42:24 INFO - PID 3479 | [#5] yui.html Cycles:180 Average:14658.54 Median:32735.67 stddev:17504.02 (53.5%) stddev-sans-first:17521.37 09:42:24 INFO - PID 3479 | Values: 619.4 620.0 680.0 680.3 693.8 12278.9 12624.3 12927.1 12956.4 13332.5 15434.2 15674.6 15694.8 16012.2 16050.3 887.9 908.1 909.4 911.6 917.8 862.0 899.5 908.5 908.9 910.1 951.8 953.3 954.0 954.6 955.6 946.8 947.6 948.2 949.4 950.4 697.4 698.4 701.7 703.3 705.9 12707.8 12934.7 13116.7 13213.7 13580.7 15864.9 15868.6 16161.3 16277.7 16337.8 11035.7 11186.8 11206.4 11216.5 11268.4 2947.3 2997.6 3012.1 3014.1 3016.8 67978.3 68341.7 68646.0 69825.0 70229.3 11797.8 12015.9 12082.1 12268.1 12276.8 20094.2 20557.5 21906.6 22001.4 22095.2 6024.7 6027.4 6097.8 6150.0 6220.9 2912.7 2925.4 2954.9 2983.0 2997.3 3460.9 3512.1 3552.6 3556.4 3731.6 763.9 774.5 781.5 783.8 786.8 584.5 606.6 607.6 613.6 622.7 8992.8 9744.3 10025.3 10243.0 10555.3 585.2 590.9 596.2 599.7 608.8 4472.8 4573.0 4606.6 4638.8 4640.9 60608.0 60844.0 61210.7 62350.4 62866.0 53829.5 54741.5 55165.0 55274.2 55652.4 48369.3 48950.8 50098.7 50380.2 50795.2 9165.0 9205.8 9266.9 9352.0 9660.1 26214.0 26749.7 27276.2 27313.7 27705.9 32071.8 32226.0 32358.8 33112.5 33132.7 11626.4 11862.5 11908.3 11991.5 12102.1 11904.7 11929.9 12048.3 12166.2 12272.9 11384.5 11458.6 11496.2 11511.7 11598.2 11369.8 11592.0 11618.5 13723.8 14500.6 12876.2 13209.5 13777.8 14029.9 14294.1 10909.1 10979.3 11114.4 11177.1 11452.5 10548.3 11216.9 11237.3 11343.4 11449.2 09:42:24 INFO - PID 3479 | -------- Summary: end -------- 09:42:24 INFO - PID 3479 | 09:42:24 INFO - TEST-INFO | 3479: exit 0 09:42:24 INFO - TEST-OK | dromaeo_css | took 1120858ms 09:42:24 INFO - TEST-START | kraken 09:42:24 INFO - operating with platform_type : linux_ 09:42:24 INFO - Initialising browser for kraken test... 09:42:24 INFO - TEST-INFO | started process 3897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOZWouh/profile http://localhost:45416/getInfo.html) 09:42:28 INFO - PID 3897 | __metrics Screen width/height:1600/1200 09:42:28 INFO - PID 3897 | colorDepth:24 09:42:28 INFO - PID 3897 | Browser inner width/height: 1024/695 09:42:28 INFO - PID 3897 | __metrics 09:42:30 INFO - TEST-INFO | 3897: exit 0 09:42:30 INFO - Browser initialized. 09:42:30 INFO - Running cycle 1/1 for kraken test... 09:42:30 INFO - TEST-INFO | started process 4069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOZWouh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:42 INFO - PID 4069 | RSS: Main: 157581312 09:42:42 INFO - PID 4069 | 09:42:45 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-beat-detection) 09:42:46 INFO - PID 4069 | RSS: Main: 163606528 09:42:46 INFO - PID 4069 | 09:42:49 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-dft) 09:42:49 INFO - PID 4069 | RSS: Main: 162050048 09:42:49 INFO - PID 4069 | 09:42:52 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-fft) 09:42:53 INFO - PID 4069 | RSS: Main: 158822400 09:42:53 INFO - PID 4069 | 09:42:55 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-oscillator) 09:42:56 INFO - PID 4069 | RSS: Main: 159805440 09:42:56 INFO - PID 4069 | 09:42:58 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:58 INFO - PID 4069 | RSS: Main: 160071680 09:42:58 INFO - PID 4069 | 09:43:02 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45416/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:02 INFO - PID 4069 | RSS: Main: 164622336 09:43:02 INFO - PID 4069 | 09:43:06 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45416/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:06 INFO - PID 4069 | RSS: Main: 163131392 09:43:06 INFO - PID 4069 | 09:43:09 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45416/tests/kraken/driver.html?testName=json-parse-financial) 09:43:10 INFO - PID 4069 | RSS: Main: 164503552 09:43:10 INFO - PID 4069 | 09:43:11 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:12 INFO - PID 4069 | RSS: Main: 164679680 09:43:12 INFO - PID 4069 | 09:43:14 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:15 INFO - PID 4069 | RSS: Main: 165134336 09:43:15 INFO - PID 4069 | 09:43:17 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:17 INFO - PID 4069 | RSS: Main: 165453824 09:43:17 INFO - PID 4069 | 09:43:20 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:21 INFO - PID 4069 | RSS: Main: 164937728 09:43:21 INFO - PID 4069 | 09:43:24 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:25 INFO - PID 4069 | RSS: Main: 164765696 09:43:25 INFO - PID 4069 | 09:43:26 INFO - PID 4069 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45416/tests/kraken/driver.html?testName=ai-astar) 09:43:27 INFO - PID 4069 | RSS: Main: 165793792 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | __start_tp_report 09:43:27 INFO - PID 4069 | _x_x_mozilla_page_load 09:43:27 INFO - PID 4069 | _x_x_mozilla_page_load_details 09:43:27 INFO - PID 4069 | |i|pagename|runs| 09:43:27 INFO - PID 4069 | |0;ai-astar;104;112;113;111;113;112;112;112;112;113 09:43:27 INFO - PID 4069 | |1;audio-beat-detection;156;125;126;176;123;124;123;124;147;124 09:43:27 INFO - PID 4069 | |2;audio-dft;165;165;164;165;170;168;176;164;165;161 09:43:27 INFO - PID 4069 | |3;audio-fft;75;76;75;114;79;75;75;75;94;74 09:43:27 INFO - PID 4069 | |4;audio-oscillator;84;82;111;84;84;86;104;84;83;105 09:43:27 INFO - PID 4069 | |5;imaging-gaussian-blur;115;115;114;114;114;113;116;119;114;115 09:43:27 INFO - PID 4069 | |6;imaging-darkroom;151;151;150;151;151;150;152;150;151;150 09:43:27 INFO - PID 4069 | |7;imaging-desaturate;95;95;94;95;94;94;96;96;96;99 09:43:27 INFO - PID 4069 | |8;json-parse-financial;54;57;54;55;54;57;58;54;57;55 09:43:27 INFO - PID 4069 | |9;json-stringify-tinderbox;57;56;56;56;56;56;56;56;56;63 09:43:27 INFO - PID 4069 | |10;stanford-crypto-aes;83;82;82;83;82;82;82;83;84;83 09:43:27 INFO - PID 4069 | |11;stanford-crypto-ccm;132;130;142;134;133;137;136;140;182;134 09:43:27 INFO - PID 4069 | |12;stanford-crypto-pbkdf2;185;192;197;192;189;194;194;195;190;193 09:43:27 INFO - PID 4069 | |13;stanford-crypto-sha256-iterative;75;79;74;73;76;72;78;75;72;74 09:43:27 INFO - PID 4069 | __end_tp_report 09:43:27 INFO - PID 4069 | __start_cc_report 09:43:27 INFO - PID 4069 | _x_x_mozilla_cycle_collect,846 09:43:27 INFO - PID 4069 | __end_cc_report 09:43:27 INFO - PID 4069 | __startTimestamp1494607407148__endTimestamp 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | ------- Summary: start ------- 09:43:27 INFO - PID 4069 | Number of tests: 14 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 09:43:27 INFO - PID 4069 | Values: 104.0 112.0 113.0 111.0 113.0 112.0 112.0 112.0 112.0 113.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:125.50 stddev:18.55 (14.8%) stddev-sans-first:18.02 09:43:27 INFO - PID 4069 | Values: 156.0 125.0 126.0 176.0 123.0 124.0 123.0 124.0 147.0 124.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#2] audio-dft Cycles:10 Average:166.30 Median:165.00 stddev:4.16 (2.5%) stddev-sans-first:4.39 09:43:27 INFO - PID 4069 | Values: 165.0 165.0 164.0 165.0 170.0 168.0 176.0 164.0 165.0 161.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:12.98 (17.3%) stddev-sans-first:13.57 09:43:27 INFO - PID 4069 | Values: 75.0 76.0 75.0 114.0 79.0 75.0 75.0 75.0 94.0 74.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:11.21 (13.3%) stddev-sans-first:11.62 09:43:27 INFO - PID 4069 | Values: 84.0 82.0 111.0 84.0 84.0 86.0 104.0 84.0 83.0 105.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:1.66 (1.4%) stddev-sans-first:1.76 09:43:27 INFO - PID 4069 | Values: 115.0 115.0 114.0 114.0 114.0 113.0 116.0 119.0 114.0 115.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 09:43:27 INFO - PID 4069 | Values: 151.0 151.0 150.0 151.0 151.0 150.0 152.0 150.0 151.0 150.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:1.51 (1.6%) stddev-sans-first:1.59 09:43:27 INFO - PID 4069 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 96.0 96.0 96.0 99.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.58 (2.8%) stddev-sans-first:1.58 09:43:27 INFO - PID 4069 | Values: 54.0 57.0 54.0 55.0 54.0 57.0 58.0 54.0 57.0 55.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.00 stddev:2.20 (3.9%) stddev-sans-first:2.33 09:43:27 INFO - PID 4069 | Values: 57.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 63.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 09:43:27 INFO - PID 4069 | Values: 83.0 82.0 82.0 83.0 82.0 82.0 82.0 83.0 84.0 83.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:136.50 stddev:15.20 (11.1%) stddev-sans-first:15.84 09:43:27 INFO - PID 4069 | Values: 132.0 130.0 142.0 134.0 133.0 137.0 136.0 140.0 182.0 134.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.10 Median:193.50 stddev:3.41 (1.8%) stddev-sans-first:2.47 09:43:27 INFO - PID 4069 | Values: 185.0 192.0 197.0 192.0 189.0 194.0 194.0 195.0 190.0 193.0 09:43:27 INFO - PID 4069 | 09:43:27 INFO - PID 4069 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:2.35 (3.1%) stddev-sans-first:2.49 09:43:27 INFO - PID 4069 | Values: 75.0 79.0 74.0 73.0 76.0 72.0 78.0 75.0 72.0 74.0 09:43:27 INFO - PID 4069 | -------- Summary: end -------- 09:43:27 INFO - PID 4069 | 09:43:28 INFO - TEST-INFO | 4069: exit 0 09:43:28 INFO - TEST-OK | kraken | took 63559ms 09:43:28 INFO - SUITE-END | took 1184s 09:43:28 INFO - Completed test suite (00:19:44) 09:43:28 INFO - javascript benchmark 09:43:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6722.367369481631, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2735.042735042734, 2755.738204870537, 2762.557990721485, 2777.6389069420984, 2778.0832325332644, 5234.842954711356, 5241.2924255225535, 5265.842024739264, 5273.5781137509, 5305.628605997582, 5322.175062865253, 5327.547158491523, 5328.973355133219, 5414.648047876885, 5454.0, 4425.645948324126, 4673.88315292117, 4736.242201247801, 4769.689970151946, 4792.04159168166, 4780.617550595944, 4825.493323201066, 4833.927491087637, 4838.5887199587905, 4858.052679727454, 4695.131400690849, 4732.787024583902, 4748.3114948332295, 4785.760711964388, 4793.18515852306, 4751.168545504557, 4774.928376074362, 4777.044591081798, 4820.204666230068, 4837.129316722989, 4675.251959686434, 4679.906401871977, 4707.270373092142, 4751.287306903958, 4754.072955773626, 5265.921011184835, 5321.600879933982, 5341.759620817073, 5343.198520221959, 5385.7307134643115, 5723.112917497794, 5790.623609465371, 5816.47651711348, 5821.88356232873, 5832.270966129234, 5854.560907931879, 5868.0, 5868.295804503444, 5869.413058694139, 5881.823545293648, 5309.123994540934, 5431.103867861838, 5440.99999999996, 5447.809326673548, 5450.8909821803345, 5930.851728706817, 5946.672932988728, 6019.729112189962, 6037.78867739627, 6080.817575472743, 5562.3881373048935, 5650.5479561634975, 5659.207710920475, 5726.169705392695, 5784.623999440023, 5835.94164058354, 5869.471747542656, 5876.764929402776, 5886.23478947734, 5939.851503712442, 5806.709664516758, 5808.651480911159, 5811.767529298781, 5823.88352232953, 5831.212786273799, 5585.357683866326, 5654.802081927113, 5666.206731057655, 5768.077107662753, 5786.04530252512, 4923.08922849274, 4930.063287975273, 4930.433000205022, 4930.7288099154175, 4947.084789313988, 4183.958160418418, 4193.161367726467, 4199.454070970754, 4217.219814334358, 4228.090960443519, 4863.805447782049, 4917.28699338601, 4924.852254432372, 4925.605951523869, 4991.925121123186, 5758.049921762946, 5775.48020678141, 5777.711114444261, 5780.0, 5834.329052159056, 4928.236123400807, 4953.950460495349, 4960.156773348467, 4966.627502937295, 4973.254011898244, 5169.4830516948, 5184.170532714747, 5201.427842937273, 5206.739663016834, 5208.739563021833, 5314.5216930476445, 5327.467253274564, 5337.8131765388025, 5358.490943360374, 5360.839174824761, 5804.21643078179, 5828.94171058301, 5840.99999999983, 5847.210626565529, 5855.180274761622, 5344.75948582307, 5346.919796203138, 5366.248725178556, 5373.946260537501, 5401.594880384066, 5745.827625171251, 5776.277965254343, 5790.739416726173, 5795.884082318415, 5807.390224026585, 5714.0, 5777.046787280052, 5872.324682661549, 5903.409659034062, 5914.940850591611, 5603.943960560342, 5629.831105066854, 5684.8294551163535, 5698.686572238401, 5725.398833122462, 5677.943220567907, 5686.2607860977805, 5700.116481945305, 5701.97364474382, 5703.543716502587, 5506.339239291311, 5540.584456165723, 5575.219469274386, 5576.052071147996, 5590.245316882331, 5582.190582365453, 5642.717864106696, 5643.746031428514, 5665.065264231355, 5726.455986681259, 5434.184872269191, 5515.951969125853, 5518.503334699896, 5518.80684176068, 5519.641223320471], "value": 5252.252246678387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.1005302629343, 691.4192078653931, 712.7469748239373, 1135.1656532448649, 1194.2595590733736, 33475.330493390116, 34110.48834267488, 34173.82913085437, 34193.0, 34316.48525272123, 31835.0, 32115.67884321156, 32173.51739723906, 32205.838970805115, 32209.83895080527, 6481.999999999988, 6553.5740176888585, 6588.3411658833975, 6676.833079173035, 6915.066466027072, 6907.827304317382, 6991.965040174792, 6993.82515437113, 6999.160100787913, 7008.264132266115, 6894.379505844473, 6989.720411183546, 6995.02069710241, 7002.299770023008, 7014.0, 6908.550944188662, 6914.06660100885, 6957.269486703899, 6961.721531138748, 7000.64996750163, 6802.897956530656, 6845.212800527953, 6853.691583878687, 6873.140857392826, 6876.828079298008, 29954.0, 30083.849580752176, 30163.0951071466, 30220.395592088036, 30299.0, 2961.481740695391, 2973.8810447582073, 2994.2215024093894, 2996.3258266889775, 3018.2152640313457, 23616.0, 23804.0, 23809.404764880845, 23919.402014949592, 23927.28218153458, 3112.393083348748, 3139.9058028259187, 3146.6381366142728, 3176.190071531768, 3180.125465496984, 114634.0, 115801.42099289534, 133569.0, 134219.0, 134862.3256883719, 36267.63732362695, 37244.81377593149, 37311.626883731355, 37436.812815935744, 37469.62530374716, 38802.0, 39074.804625976685, 39139.0, 39156.412653810214, 39210.0, 11210.719732006764, 11241.437928103562, 11327.037201837937, 11331.376774277494, 11347.092232621535, 9063.410878293022, 9063.54682265884, 9123.635054597875, 9137.954310228406, 9139.588718507683, 11627.59303424376, 11644.2431241969, 11802.701702812683, 11837.408129593487, 11915.523379064914, 4976.377952755905, 5075.822346217865, 5119.129747942859, 5122.1804511278015, 5176.120059589879, 869.7390782765145, 909.7634615000147, 910.8451563234266, 912.1995473895079, 934.0892629686002, 20113.798862011485, 21201.681974770392, 21249.256276030574, 21326.88932313049, 21395.893020534797, 969.6557722008727, 982.1062832822098, 1009.6466236817203, 1011.9696409107738, 1017.1252722658508, 10833.241673082808, 11311.773764524663, 13910.513132040533, 14519.0, 14587.416503339748, 147556.0, 149405.2529737366, 150674.0, 150983.0, 151710.0, 42153.36769948453, 42545.787271064066, 42624.57375426268, 42726.57273427288, 42896.57103428988, 1212.4604550974907, 1248.494359784289, 1252.511520507003, 1256.064232147038, 1256.2901960392533, 23672.0, 23974.0, 24844.627330590418, 24961.50076998486, 24985.500289993735, 29782.0, 29898.85050574733, 30117.247068823453, 30172.54741178928, 30208.848955755082, 146700.2664986711, 146932.0, 147007.0, 147515.26242369149, 147601.0, 27881.86059069773, 28536.0, 28755.568666470437, 29534.409311814074, 29547.261318467212, 35088.47367289442, 35312.47031294481, 35387.0, 35413.29173416569, 35449.46825797667, 25449.236522904343, 26271.211863643355, 26554.867225663747, 27453.17640470789, 27518.0, 26547.336316591467, 26720.732792672603, 27132.457350853267, 27344.0, 28088.578671319538, 30081.0, 30451.0, 30741.692583073884, 30780.53829192519, 30818.53772193374, 25141.371465713502, 26856.462870742867, 26985.595216072168, 27079.0, 27416.58875116835, 20478.897605511876, 22018.0, 22028.229011984502, 22202.777972220716, 22375.216867409563], "value": 14219.686767201434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.38267438203025, 431.3092676707307, 431.9676024298178, 444.1871375383049, 449.9482559505658, 16867.73491988101, 17011.0, 17833.732494012602, 17852.64294714108, 17986.100694965247, 18056.368027119053, 18282.0, 19179.32872349468, 19346.806531934675, 19409.708854367196, 5444.591655625824, 5502.8349149525475, 5581.107022876341, 5596.720163991805, 5613.0, 5522.6134170607875, 5679.630823996447, 5689.146628005811, 5690.630109042899, 5698.0, 5451.727413629323, 5563.193336966137, 5580.0, 5613.550915926737, 5620.634658747189, 5430.348358197002, 5556.666600003992, 5566.165075238706, 5597.776088956437, 5597.944020559783, 5012.8997420051755, 5029.19532874742, 5031.471695471996, 5065.898682026375, 5067.391912970467, 21919.12323507058, 22200.555988880293, 22297.44256393587, 22362.10551577935, 22370.32889013332, 1666.475060355984, 1694.5509439998286, 1700.8214137515631, 1706.4965835078558, 1714.0572685023187, 14705.632359191106, 14773.704525909421, 14890.106593604418, 15079.849201508065, 15228.771568426482, 2046.5190680190144, 2049.5695903860205, 2108.3674897530677, 2112.0495776900457, 2135.9145634174615, 81052.0, 81796.0, 81992.59003705003, 82107.5894620529, 83404.16595834025, 11244.550217991353, 11315.321080735182, 11345.0, 11484.368359740127, 11501.137414693763, 15686.76469852953, 15850.128242946748, 15869.68260634781, 15902.284397202153, 15948.521544353687, 7583.27958843909, 7697.4226932980255, 7730.961345193238, 7871.33093687043, 7889.17163697815, 6967.721291148398, 7034.648267586703, 7048.823779405556, 7201.0, 7231.566106033655, 7068.611226382598, 7080.973258877434, 7151.2491188424465, 7215.783526494213, 7337.376323012497, 2102.35878057191, 2114.524232047777, 2130.3076500137518, 2168.371172359998, 2185.89070546472, 844.273924424994, 878.2447095497866, 879.6261588824724, 887.2059506741431, 905.8414777413926, 17073.7438938416, 17411.303547857944, 17707.0, 18017.54956126081, 18158.45524634263, 864.9697260595849, 870.2602787630464, 882.43965082172, 883.5979629268668, 901.8421776189272, 9430.62277508892, 9767.316287859923, 9866.753331166778, 9867.851982220272, 9999.450030248407, 321797.0, 334896.0, 335516.0, 337477.0, 341812.0, 73203.63398182976, 74908.25091749121, 76089.23910760932, 76103.61948190223, 78342.60828695934, 946.1248345280588, 973.8003709239589, 978.0659470205936, 981.215027977615, 1041.317936751429, 16067.0, 16645.83354166443, 16812.747808783122, 17609.735853961945, 17706.91146544259, 40128.0, 40520.04658625653, 40621.0, 40621.390679139244, 40854.0, 47254.527454725016, 48841.26738099002, 49297.753511232215, 51490.0, 51672.741636291576, 7848.372130229453, 8039.0, 8055.516668999879, 8244.587770611566, 8407.663693452194, 12896.161749486253, 13215.207087574776, 13294.40175192138, 13303.135296206103, 13465.124766890121, 10832.458377080957, 11097.944510277397, 11133.830947750694, 11392.772144556897, 11538.076953843505, 10160.695179144637, 10558.472076395996, 10603.734906627396, 10624.521896514521, 10635.787284254116, 11382.829257561309, 11386.316820990767, 11471.254368466023, 11702.590409335633, 11873.0, 7953.125156232925, 8021.197880211932, 8048.476849004796, 8177.550234737147, 8254.215849494289, 10133.543990520297, 10198.796024079626, 10395.116415104801, 10493.317934334244, 10548.103411209826], "value": 8891.486065707779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.432355440052, 1308.3719814489045, 1312.1405479410978, 1314.08014389927, 1335.5726167626358, 10172.949135254323, 10490.947545262263, 10670.199735019876, 10670.78658426831, 10851.186161037935, 10535.789284214312, 10708.0, 10710.357378557272, 10716.196285278616, 10722.463876806167, 2170.8480406371523, 2203.46015226269, 2205.6691496275607, 2213.811825994784, 2228.2312602152233, 2248.0782879019607, 2279.4985103277254, 2283.5547068321684, 2288.9198878039274, 2291.7249930008425, 2253.4479052632128, 2265.954680906389, 2289.0843662534953, 2292.6561015847587, 2300.424893776556, 2184.497565559914, 2213.568354170929, 2217.6008318502663, 2217.8225741940687, 2221.1559607349263, 2085.718428012214, 2228.220122956968, 2233.050953344822, 2234.084025549517, 2237.832162587796, 10392.428416437093, 10509.632162874263, 10516.421596812172, 10518.684439466828, 10526.842097368546, 5589.608727389084, 5861.85345366365, 5866.501347385477, 5867.559933004999, 5871.089981052901, 3289.1612638777196, 3291.5062740588864, 3316.137804170909, 3454.896353109411, 3545.1137215696076, 1043.3844032021143, 1062.0176336888424, 1094.3379255550358, 1100.3452945497415, 1107.147496427746, 14660.047096938664, 14726.042807217496, 14785.112893226333, 14793.408263669333, 14829.703405931929, 4766.904661906812, 4898.657094003385, 5011.774470148852, 5054.595632349403, 5074.873128171751, 10918.617848375268, 10966.506507207196, 11002.119830413547, 11013.559457621766, 11061.834072488919, 5577.358603760538, 5629.240052592848, 5634.549236061105, 5643.548516118783, 5647.661140331593, 4970.826021089245, 5195.818146364859, 5289.920651190235, 5321.574274058144, 5368.114261146867, 3831.63599458051, 3952.6047395260243, 3997.800109994547, 4062.918741625151, 4077.4699289092823, 1077.3966578715945, 1085.6146068145695, 1105.5577768892347, 1109.040679811973, 1111.9833202501968, 655.9704813283414, 677.7119724117231, 686.7115811359241, 705.1115594351154, 705.1291654806311, 5313.601479889024, 5692.23154874095, 5958.314793798769, 6048.032314829694, 6134.938650613437, 540.7269328988835, 562.971851407428, 564.0833645326345, 564.6894208185481, 566.6711561388537, 3343.1474973881504, 3384.1032126486502, 3697.5378077740284, 3713.814309284525, 3864.30442520349, 12895.806562901564, 13558.050936434354, 13594.524191653245, 13617.659558510919, 13628.795568066487, 13403.061785675105, 13410.195388276734, 13432.932835335956, 13440.596782096552, 13463.259520726258, 7410.592417417094, 7799.961000194962, 7816.179301173409, 7828.647710853025, 7844.097928738268, 5911.379305172895, 6079.939200607937, 6157.722902469489, 6226.750929962751, 6352.237731472068, 12194.878051219373, 12273.263604183778, 12348.259104453402, 12530.37348132608, 12537.373131343578, 12448.0, 12456.252624842538, 12567.120301579167, 12622.621321360373, 12810.871891280967, 7736.342410894912, 7902.367810575255, 7950.9266249057955, 7987.440879138405, 8008.639611217625, 8814.162654547808, 8886.777830554287, 8951.0, 8956.193942545202, 8976.326775491734, 7486.962565187139, 7665.961670191613, 7685.346745526693, 7910.0, 8089.87865182011, 7926.762197134095, 8000.599970001593, 8026.197380261927, 8031.919680803117, 8096.190380962093, 7302.5253358533655, 7403.259674032553, 7435.591042492715, 7452.739154129579, 7457.067866516685, 5358.383785864676, 5392.676439413648, 5407.459254074561, 5462.972685136708, 5669.688167150846, 5140.537351638371, 5173.922391164211, 5208.583313335, 5223.843284701465, 5388.380336261223], "value": 4726.042188064832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2756022217454, 398.4421809466747, 404.5226632573562, 404.6095517825299, 409.35730902483095, 5385.703786291752, 5581.046633678211, 5602.24369710089, 5676.602637815355, 5683.744231509581, 5362.705051222181, 5499.587530935186, 5534.778608855641, 5539.778408863641, 5544.362398324194, 4376.868693939179, 4382.627476664487, 4388.912221755563, 4393.890152746191, 4402.1195760847795, 4286.699931004831, 4345.869623911272, 4385.714928529651, 4394.47266328041, 4402.713823601472, 4340.0, 4340.500842403117, 4340.913181736363, 4342.826286948534, 4352.912941741163, 4339.218940590692, 4353.695241333108, 4358.8474403395885, 4360.345948107777, 4362.629176519999, 3866.072142685763, 3946.0, 3978.1446988897237, 3980.383040628707, 3981.28336899358, 5399.2980912481125, 5432.837014889559, 5457.536109430703, 5462.781488740446, 5503.862403439906, 5186.351706036746, 5205.739713014372, 5209.400918894337, 5210.244514545369, 5226.55574276187, 5740.225069615591, 5852.766803354457, 5864.472197502203, 5921.526277897758, 5928.547505861092, 4438.755868427235, 4468.128714900596, 4471.28459446487, 4472.1502914446155, 4487.887802804956, 5994.220751302303, 6158.784442544535, 6174.135621013017, 6196.87606247877, 6211.285702144266, 4150.8547200847825, 4178.6657067434535, 4179.540250572434, 4183.100633363781, 4187.120704652058, 4184.476940382452, 4207.4951005878875, 4232.026633874226, 4237.576242375738, 4241.215375155606, 4753.83361582343, 4791.904161916742, 4862.294967229732, 4881.9511804881495, 4886.755662216875, 5829.213056237439, 5847.585073269739, 5849.61977471463, 5849.853753656193, 5859.736311865976, 1443.1773888883445, 1449.681070164562, 1461.751502244621, 1465.1136062682137, 1473.2118316700514, 974.4348277998744, 977.7555611097225, 980.2158273381267, 987.2546227598117, 998.1964518562627, 5097.1844504879045, 5119.744012799345, 5124.897502049938, 5131.7177555234075, 5165.354330708661, 5991.4907232884825, 6045.183900173508, 6061.636301821904, 6098.1157732128595, 6143.201383820075, 4999.875003124951, 5076.6953982760415, 5084.652622008203, 5105.0, 5179.792808287626, 3189.186757376854, 3249.985009294253, 3250.658680838525, 3258.837058147083, 3261.4781634938295, 5499.020352673035, 5573.0, 5594.944050559524, 5605.150300400858, 5608.270924779753, 6179.721912513947, 6201.782937597162, 6205.2553693557065, 6216.7824126155365, 6251.468625166821, 5616.578756593353, 5616.9608622404985, 5618.129189975561, 5622.493975542221, 5632.7746890123935, 5990.371011043778, 6024.33732289439, 6024.969875150597, 6075.665838378932, 6151.292601350902, 5857.502112320501, 5999.560325359115, 6005.789797357072, 6035.9094613579955, 6051.425114614105, 5616.971915140398, 5635.746391412315, 5642.915356269741, 5647.644565304216, 5659.340110148224, 4144.917101657889, 4182.937255941102, 4196.160767846504, 4200.012996945777, 4204.264253755642, 6010.398960103955, 6127.264728232641, 6156.78451254204, 6178.281556115295, 6205.81382558524, 5925.318588362394, 5931.851703707442, 5936.436038576328, 5944.019236825875, 5949.881002380015, 5795.884082318415, 5913.70431478433, 5947.9702601486715, 5956.821295361146, 5959.95700752358, 5755.223044889054, 5794.594378393472, 5803.419658034163, 5821.214136091573, 5831.241938547962, 5930.466258036798, 5957.076653118774, 5957.863400697289, 5964.433378829004, 5984.491318237999, 5600.679592840345, 5663.886722265449, 5723.227364305932, 5759.0209664356325, 5761.971190144022], "value": 4443.865809580082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4486906653079, 619.9876002479954, 679.9558028728133, 680.3400701319719, 693.7675878580675, 12278.877211227886, 12624.305663188521, 12927.09510334277, 12956.416961236744, 13332.533361332355, 15434.151121688303, 15674.608134796606, 15694.843051569482, 16012.19939003051, 16050.27773750181, 887.9378443508957, 908.0964440381796, 909.4043401571981, 911.6399022386187, 917.7843206846386, 862.0, 899.4917871402637, 908.504864848659, 908.9136532029447, 910.0808183734442, 951.8239125761756, 953.3136141977765, 953.9570719317647, 954.5990683912738, 955.5604421965869, 946.7633091727068, 947.5593848860278, 948.1750876737214, 949.4208532794989, 950.4487397309543, 697.3584302441766, 698.4447364345358, 701.6737217194029, 703.2791388826442, 705.8800003999332, 12707.809382859172, 12934.741305173939, 13116.737665246641, 13213.73572528544, 13580.728385432334, 15864.92067539655, 15868.603284917854, 16161.272742726605, 16277.674446511122, 16337.83662163375, 11035.668929932115, 11186.832197517044, 11206.383648899307, 11216.495257713423, 11268.436578171058, 2947.3221159133304, 2997.6252968378953, 3012.0813151988636, 3014.095771268611, 3016.8039077460116, 67978.3202167982, 68341.65829170872, 68646.0, 69825.0, 70229.2977070228, 11797.823032654516, 12015.879841201651, 12082.093842961638, 12268.141230113984, 12276.815847762291, 20094.19623215055, 20557.486062848548, 21906.561868762536, 22001.449963751034, 22095.226667066574, 6024.668643224665, 6027.36712645166, 6097.847553811191, 6150.0, 6220.875582488325, 2912.7378535931443, 2925.414917016605, 2954.896578619738, 2983.030515082607, 2997.2806526433933, 3460.8615655374006, 3512.13952581614, 3552.626974167727, 3556.3776339140545, 3731.6268373162466, 763.9083310002835, 774.4578794843632, 781.4725060584083, 783.7805414483954, 786.7679034684782, 584.5206930317185, 606.5663050918614, 607.5959486941134, 613.6287546034584, 622.6637615687478, 8992.759051186018, 9744.269179811543, 10025.298229124037, 10243.0, 10555.26113172086, 585.1778251556569, 590.9497692696083, 596.2189531713469, 599.7391134856351, 608.8417011576934, 4472.843450479218, 4572.977135114304, 4606.585407313358, 4638.768061596907, 4640.86077417678, 60608.0, 60844.0, 61210.69394652998, 62350.37649623537, 62866.0, 53829.46170538245, 54741.452585474435, 55165.0, 55274.17088743672, 55652.44347556554, 48369.27446088311, 48950.75524622354, 50098.749506252236, 50380.244296335586, 50795.23807142896, 9164.95417522908, 9205.76985575366, 9266.860997085185, 9351.953240233755, 9660.130588247092, 26214.019336326037, 26749.732502674724, 27276.181714548595, 27313.726862731117, 27705.86147069252, 32071.839640801645, 32226.0, 32358.83820580882, 33112.50331245081, 33132.66867331392, 11626.360550169822, 11862.525498979945, 11908.285502869856, 11991.460384282555, 12102.092343074128, 11904.702382440508, 11929.940350298193, 12048.337341446304, 12166.209196402206, 12272.877271227173, 11384.48769805344, 11458.598949036743, 11496.195266331611, 11511.654650360502, 11598.18812683138, 11369.772604547697, 11592.0, 11618.535258589562, 13723.794143088062, 14500.637484062983, 12876.163049401759, 13209.537666181637, 13777.828884544926, 14029.859701402855, 14294.070885392832, 10909.127269818555, 10979.341239525655, 11114.388708621103, 11177.105831533296, 11452.484638191134, 10548.314359566604, 11216.864002223165, 11237.3257604544, 11343.376114313793, 11449.198556100993], "value": 6616.60591732498, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 111.0, 113.0, 112.0, 112.0, 112.0, 112.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 126.0, 176.0, 123.0, 124.0, 123.0, 124.0, 147.0, 124.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 165.0, 170.0, 168.0, 176.0, 164.0, 165.0, 161.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 114.0, 79.0, 75.0, 75.0, 75.0, 94.0, 74.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 111.0, 84.0, 84.0, 86.0, 104.0, 84.0, 83.0, 105.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 113.0, 116.0, 119.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 151.0, 150.0, 152.0, 150.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 96.0, 96.0, 96.0, 99.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 55.0, 54.0, 57.0, 58.0, 54.0, 57.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 63.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 82.0, 82.0, 82.0, 83.0, 84.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 142.0, 134.0, 133.0, 137.0, 136.0, 140.0, 182.0, 134.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 192.0, 197.0, 192.0, 189.0, 194.0, 194.0, 195.0, 190.0, 193.0], "value": 192.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 74.0, 73.0, 76.0, 72.0, 78.0, 75.0, 72.0, 74.0], "value": 74.8, "unit": "score"}]}]} 09:43:28 INFO - Return code: 0 09:43:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:43:28 INFO - # TBPL SUCCESS # 09:43:28 INFO - Running post-action listener: _resource_record_post_action 09:43:28 INFO - [mozharness: 2017-05-12 16:43:28.941836Z] Finished run-tests step (success) 09:43:28 INFO - Running post-run listener: _resource_record_post_run 09:43:29 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7974912; Write bytes: 379396096; Read time: 2372; Write time: 626408 09:43:29 INFO - TinderboxPrint: CPU usage
13.3% 09:43:29 INFO - TinderboxPrint: I/O read bytes / time
7,974,912 / 2,372 09:43:29 INFO - TinderboxPrint: I/O write bytes / time
379,396,096 / 626,408 09:43:29 INFO - TinderboxPrint: CPU idle
8,307.8 (86.7%) 09:43:29 INFO - TinderboxPrint: CPU user
1,213.7 (12.7%) 09:43:29 INFO - TinderboxPrint: Swap in / out
0 / 0 09:43:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 118501376; Read time: 0; Write time: 276060 09:43:29 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5627904; Write bytes: 260321280; Read time: 1796; Write time: 350312 09:43:29 INFO - Running post-run listener: _upload_blobber_files 09:43:29 INFO - Blob upload gear active. 09:43:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:29 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 09:43:29 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'] 09:43:29 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 09:43:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:33 INFO - (blobuploader) - INFO - Done attempting. 09:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:34 INFO - (blobuploader) - INFO - Done attempting. 09:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:35 INFO - (blobuploader) - INFO - Done attempting. 09:43:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:43:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:35 INFO - (blobuploader) - INFO - Done attempting. 09:43:35 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:35 INFO - Return code: 0 09:43:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:43:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eece7f90fd0f27c4abcfa0c2db4832f683eb501b4c967e09d8d3e7162aecb6661324ce7c3b10cfe0917a485650a5c085e7dbe9307fdb0301abd92b834e932bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec68bf63a7f2e9079ea72f650e659cc37fdcb79a4aae7692304d0e41b71ee8bbdbe0217c795e7600bb530960001537361d72335b1529c5ebefccce86d814d56e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b772ccfa5f553849e5c1f4775d1cd1055947aa29e594307919ceb4f46cc163abe04e7fbf07414f76c03245e2edb10ffc5d3570822466e071d520fba955d50c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b119d54cc3b2a1d1d3dcfe61b21aead3cd230f160cadb6a42445c9ccd1f393e1be73c77efc083d06ebb5051b7de55e38d2c43427dc6d0c45f84608b3ebef7db5"} 09:43:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:43:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:43:35 INFO - Contents: 09:43:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eece7f90fd0f27c4abcfa0c2db4832f683eb501b4c967e09d8d3e7162aecb6661324ce7c3b10cfe0917a485650a5c085e7dbe9307fdb0301abd92b834e932bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec68bf63a7f2e9079ea72f650e659cc37fdcb79a4aae7692304d0e41b71ee8bbdbe0217c795e7600bb530960001537361d72335b1529c5ebefccce86d814d56e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b772ccfa5f553849e5c1f4775d1cd1055947aa29e594307919ceb4f46cc163abe04e7fbf07414f76c03245e2edb10ffc5d3570822466e071d520fba955d50c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b119d54cc3b2a1d1d3dcfe61b21aead3cd230f160cadb6a42445c9ccd1f393e1be73c77efc083d06ebb5051b7de55e38d2c43427dc6d0c45f84608b3ebef7db5"} 09:43:35 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:35 INFO - Copying logs to upload dir... 09:43:35 INFO - mkdir: /builds/slave/test/build/upload/logs 09:43:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.097916 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 09:43:35.967600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:35.970820) ========= 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=af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013 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/eece7f90fd0f27c4abcfa0c2db4832f683eb501b4c967e09d8d3e7162aecb6661324ce7c3b10cfe0917a485650a5c085e7dbe9307fdb0301abd92b834e932bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec68bf63a7f2e9079ea72f650e659cc37fdcb79a4aae7692304d0e41b71ee8bbdbe0217c795e7600bb530960001537361d72335b1529c5ebefccce86d814d56e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b772ccfa5f553849e5c1f4775d1cd1055947aa29e594307919ceb4f46cc163abe04e7fbf07414f76c03245e2edb10ffc5d3570822466e071d520fba955d50c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b119d54cc3b2a1d1d3dcfe61b21aead3cd230f160cadb6a42445c9ccd1f393e1be73c77efc083d06ebb5051b7de55e38d2c43427dc6d0c45f84608b3ebef7db5"} build_url:https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eece7f90fd0f27c4abcfa0c2db4832f683eb501b4c967e09d8d3e7162aecb6661324ce7c3b10cfe0917a485650a5c085e7dbe9307fdb0301abd92b834e932bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec68bf63a7f2e9079ea72f650e659cc37fdcb79a4aae7692304d0e41b71ee8bbdbe0217c795e7600bb530960001537361d72335b1529c5ebefccce86d814d56e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b772ccfa5f553849e5c1f4775d1cd1055947aa29e594307919ceb4f46cc163abe04e7fbf07414f76c03245e2edb10ffc5d3570822466e071d520fba955d50c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b119d54cc3b2a1d1d3dcfe61b21aead3cd230f160cadb6a42445c9ccd1f393e1be73c77efc083d06ebb5051b7de55e38d2c43427dc6d0c45f84608b3ebef7db5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:35.996121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:35.996459) ========= 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=af724c981e2a0f424dbabf99000001e7-1494605768.234543-2146278013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:36.078259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:43:36.078591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:43:36.078886) ========= ========= Total master_lag: 0.20 =========