builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1495035853.99 results: success (0) revision: 85e5d15c31691c89b82d6068c26260416493071f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:13.988354) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:13.988767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:13.989057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:14.004629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:14.004883) ========= 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=232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 08:44:14-- 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% 54.1M=0s 2017-05-17 08:44:14 (54.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.409839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:14.426935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:14.427212) ========= 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=232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021033 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:14.486134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:14.486440) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 85e5d15c31691c89b82d6068c26260416493071f --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 85e5d15c31691c89b82d6068c26260416493071f --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=232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 08:44:14,620 truncating revision to first 12 chars 2017-05-17 08:44:14,620 Setting DEBUG logging. 2017-05-17 08:44:14,620 attempt 1/10 2017-05-17 08:44:14,620 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/85e5d15c3169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 08:44:15,241 unpacking tar archive at: mozilla-central-85e5d15c3169/testing/mozharness/ program finished with exit code 0 elapsedTime=0.964346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:15.466399) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:15.466668) ========= script_repo_revision: 85e5d15c31691c89b82d6068c26260416493071f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:15.470078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:15.470387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 08:44:15.482639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-05-17 08:44:15.485911) ========= /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=232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:15 INFO - MultiFileLogger online at 20170517 08:44:15 in /builds/slave/test 08:44:15 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 08:44:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:15 INFO - {'append_to_log': False, 08:44:15 INFO - 'base_work_dir': '/builds/slave/test', 08:44:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:44:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:15 INFO - 'branch': 'Firefox-Non-PGO', 08:44:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:15 INFO - 'config_files': ('talos/linux_config.py',), 08:44:15 INFO - 'default_actions': ('clobber', 08:44:15 INFO - 'read-buildbot-config', 08:44:15 INFO - 'download-and-extract', 08:44:15 INFO - 'populate-webroot', 08:44:15 INFO - 'create-virtualenv', 08:44:15 INFO - 'install', 08:44:15 INFO - 'run-tests'), 08:44:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:15 INFO - 'download_minidump_stackwalk': True, 08:44:15 INFO - 'download_symbols': 'ondemand', 08:44:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:15 INFO - 'gecko_profile': False, 08:44:15 INFO - 'gecko_profile_interval': 0, 08:44:15 INFO - 'installer_path': 'installer.exe', 08:44:15 INFO - 'log_level': 'info', 08:44:15 INFO - 'log_name': 'talos', 08:44:15 INFO - 'log_to_console': True, 08:44:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:15 INFO - 'opt_config_files': (), 08:44:15 INFO - 'pip_index': False, 08:44:15 INFO - 'suite': 'dromaeojs-e10s', 08:44:15 INFO - 'system_bits': '32', 08:44:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:15 INFO - 'title': 'talos-linux64-ix-025', 08:44:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:15 INFO - 'use_talos_json': True, 08:44:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:15 INFO - 'work_dir': 'build'} 08:44:15 INFO - [mozharness: 2017-05-17 15:44:15.715313Z] Running clobber step. 08:44:15 INFO - Running pre-action listener: _resource_record_pre_action 08:44:15 INFO - Running main action method: clobber 08:44:15 INFO - rmtree: /builds/slave/test/build 08:44:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:17 INFO - Running post-action listener: _resource_record_post_action 08:44:17 INFO - [mozharness: 2017-05-17 15:44:17.226622Z] Finished clobber step (success) 08:44:17 INFO - [mozharness: 2017-05-17 15:44:17.226721Z] Running read-buildbot-config step. 08:44:17 INFO - Running pre-action listener: _resource_record_pre_action 08:44:17 INFO - Running main action method: read_buildbot_config 08:44:17 INFO - Using buildbot properties: 08:44:17 INFO - { 08:44:17 INFO - "project": "", 08:44:17 INFO - "product": "firefox", 08:44:17 INFO - "who": "ffxbld@noreply.mozilla.org", 08:44:17 INFO - "installer_path": "public/build/target.tar.bz2", 08:44:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:44:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:44:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:44:17 INFO - "stage_platform": "linux64", 08:44:17 INFO - "basedir": "/builds/slave/test", 08:44:17 INFO - "buildnumber": 837, 08:44:17 INFO - "platform": "ubuntu64_hw", 08:44:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:44:17 INFO - "slavebuilddir": "test", 08:44:17 INFO - "taskId": "RITf_iwSTf6mK_HiIJgmBg", 08:44:17 INFO - "branch": "mozilla-central", 08:44:17 INFO - "script_repo_revision": "production", 08:44:17 INFO - "revision": "85e5d15c31691c89b82d6068c26260416493071f", 08:44:17 INFO - "slavename": "talos-linux64-ix-025", 08:44:17 INFO - "repo_path": "mozilla-central" 08:44:17 INFO - } 08:44:17 INFO - Finding installer, test and symbols from parent task. 08:44:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RITf_iwSTf6mK_HiIJgmBg'}, attempt #1 08:44:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RITf_iwSTf6mK_HiIJgmBg'}, attempt #1 08:44:18 INFO - Task dependencies: Ma6pZGD0TPKKur90mE0p3A 08:44:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A'}, attempt #1 08:44:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2 08:44:18 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/test_packages.json 08:44:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.crashreporter-symbols.zip 08:44:18 INFO - Running post-action listener: _resource_record_post_action 08:44:18 INFO - [mozharness: 2017-05-17 15:44:18.622141Z] Finished read-buildbot-config step (success) 08:44:18 INFO - [mozharness: 2017-05-17 15:44:18.622456Z] Running download-and-extract step. 08:44:18 INFO - Running pre-action listener: _resource_record_pre_action 08:44:18 INFO - Running main action method: download_and_extract 08:44:18 INFO - mkdir: /builds/slave/test/build/tests 08:44: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')]} 08:44:18 INFO - trying https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.test_packages.json 08:44:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:44:19 INFO - Downloaded 986 bytes. 08:44:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:44:19 INFO - Using the following test package requirements: 08:44:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:44:19 INFO - u'common': [u'target.common.tests.zip'], 08:44:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:44:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:44:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:44:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:44:19 INFO - u'mozbase': [u'target.common.tests.zip'], 08:44:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:44:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:44:19 INFO - u'web-platform': [u'target.common.tests.zip', 08:44:19 INFO - u'target.web-platform.tests.zip'], 08:44:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:44:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:44:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.common.tests.zip 08:44:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.common.tests.zip into memory 08:44:49 INFO - Content-Length response header: 62452183 08:44:49 INFO - Bytes received: 62452183 08:44:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:44:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.common.tests.zip 08:44:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.common.tests.zip into memory 08:45:01 INFO - Content-Length response header: 62452183 08:45:01 INFO - Bytes received: 62452183 08:45:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.talos.tests.zip 08:45:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:45:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.talos.tests.zip into memory 08:45:13 INFO - Content-Length response header: 14410069 08:45:13 INFO - Bytes received: 14410069 08:45: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')]} 08:45:14 INFO - trying https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2 08:45:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:45:16 INFO - Downloaded 63265659 bytes. 08:45:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2 08:45:16 INFO - mkdir: /builds/slave/test/properties 08:45:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:16 INFO - Contents: 08:45:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2 08:45:16 INFO - Running post-action listener: _resource_record_post_action 08:45:16 INFO - Running post-action listener: set_extra_try_arguments 08:45:16 INFO - [mozharness: 2017-05-17 15:45:16.287568Z] Finished download-and-extract step (success) 08:45:16 INFO - [mozharness: 2017-05-17 15:45:16.287665Z] Running populate-webroot step. 08:45:16 INFO - Running pre-action listener: _resource_record_pre_action 08:45:16 INFO - Running main action method: populate_webroot 08:45:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:16 INFO - '--tppagecycles', 08:45:16 INFO - '7'], 08:45:16 INFO - 'tests': ['tsvgm']}}, 08:45:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['damp', 'tps']}, 08:45:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'tests': ['damp', 'tps']}, 08:45:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['dromaeo_dom']}, 08:45:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:45:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:45:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'tests': ['ts_paint', 'tp5o']}, 08:45:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['a11yr', 08:45:16 INFO - 'ts_paint', 08:45:16 INFO - 'tpaint', 08:45:16 INFO - 'sessionrestore', 08:45:16 INFO - 'sessionrestore_no_auto_restore', 08:45:16 INFO - 'tabpaint']}, 08:45:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:16 INFO - 'ts_paint', 08:45:16 INFO - 'tpaint', 08:45:16 INFO - 'sessionrestore', 08:45:16 INFO - 'sessionrestore_no_auto_restore', 08:45:16 INFO - 'tabpaint']}, 08:45:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:16 INFO - 'ts_paint', 08:45:16 INFO - 'tpaint', 08:45:16 INFO - 'sessionrestore', 08:45:16 INFO - 'sessionrestore_no_auto_restore', 08:45:16 INFO - 'tabpaint']}, 08:45:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:16 INFO - 'ts_paint', 08:45:16 INFO - 'tpaint', 08:45:16 INFO - 'sessionrestore', 08:45:16 INFO - 'sessionrestore_no_auto_restore', 08:45:16 INFO - 'tabpaint']}, 08:45:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['a11yr', 08:45:16 INFO - 'ts_paint', 08:45:16 INFO - 'tpaint', 08:45:16 INFO - 'sessionrestore', 08:45:16 INFO - 'sessionrestore_no_auto_restore', 08:45:16 INFO - 'tabpaint']}, 08:45:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['a11yr', 08:45:16 INFO - 'ts_paint', 08:45:16 INFO - 'tpaint', 08:45:16 INFO - 'sessionrestore', 08:45:16 INFO - 'sessionrestore_no_auto_restore', 08:45:16 INFO - 'tabpaint']}, 08:45:16 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:45:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:45:16 INFO - 'bloom_basic_ref']}, 08:45:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['tsvgx', 08:45:16 INFO - 'tsvgr_opacity', 08:45:16 INFO - 'tart', 08:45:16 INFO - 'tscrollx', 08:45:16 INFO - 'cart', 08:45:16 INFO - 'tsvg_static']}, 08:45:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:16 INFO - 'tsvgr_opacity', 08:45:16 INFO - 'tart', 08:45:16 INFO - 'tscrollx', 08:45:16 INFO - 'cart', 08:45:16 INFO - 'tsvg_static']}, 08:45:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'talos_options': ['--disable-e10s'], 08:45:16 INFO - 'tests': ['tp5o']}, 08:45:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:45:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'talos_options': ['--disable-e10s', 08:45:16 INFO - '--xperf_path', 08:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:16 INFO - 'tests': ['tp5n']}, 08:45:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:45:16 INFO - 'talos_options': ['--xperf_path', 08:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:16 INFO - 'tests': ['tp5n']}}, 08:45:16 INFO - 'talos.zip': {'path': '', 08:45:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:16 INFO - Running post-action listener: _resource_record_post_action 08:45:16 INFO - [mozharness: 2017-05-17 15:45:16.304400Z] Finished populate-webroot step (success) 08:45:16 INFO - [mozharness: 2017-05-17 15:45:16.304489Z] Running create-virtualenv step. 08:45:16 INFO - Running pre-action listener: _resource_record_pre_action 08:45:16 INFO - Running main action method: create_virtualenv 08:45:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:16 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 08:45:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:16 INFO - Using real prefix '/usr' 08:45:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:18 INFO - Installing pip.................done. 08:45:18 INFO - Return code: 0 08:45:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:45:19 INFO - Reading from file tmpfile_stdout 08:45:19 INFO - Output received: 08:45:19 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) 08:45:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:19 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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:19 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 08:45:19 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 08:45:19 INFO - Using env: {'DISPLAY': ':0', 08:45:19 INFO - 'HOME': '/home/cltbld', 08:45:19 INFO - 'LANG': 'en_US.UTF-8', 08:45:19 INFO - 'LANGUAGE': 'en_US:en', 08:45:19 INFO - 'LOGNAME': 'cltbld', 08:45:19 INFO - 'MAIL': '/var/mail/cltbld', 08:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:19 INFO - 'MOZ_NO_REMOTE': '1', 08:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:19 INFO - 'NO_EM_RESTART': '1', 08:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:19 INFO - 'PWD': '/builds/slave/test', 08:45:19 INFO - 'SHELL': '/bin/bash', 08:45:19 INFO - 'SHLVL': '1', 08:45:19 INFO - 'TERM': 'linux', 08:45:19 INFO - 'TMOUT': '86400', 08:45:19 INFO - 'USER': 'cltbld', 08:45:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:19 INFO - '_': '/tools/buildbot/bin/python'} 08:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:19 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 08:45:19 INFO - Cleaning up... 08:45:19 INFO - Return code: 0 08:45:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:19 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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:19 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 08:45:19 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 08:45:19 INFO - Using env: {'DISPLAY': ':0', 08:45:19 INFO - 'HOME': '/home/cltbld', 08:45:19 INFO - 'LANG': 'en_US.UTF-8', 08:45:19 INFO - 'LANGUAGE': 'en_US:en', 08:45:19 INFO - 'LOGNAME': 'cltbld', 08:45:19 INFO - 'MAIL': '/var/mail/cltbld', 08:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:19 INFO - 'MOZ_NO_REMOTE': '1', 08:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:19 INFO - 'NO_EM_RESTART': '1', 08:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:19 INFO - 'PWD': '/builds/slave/test', 08:45:19 INFO - 'SHELL': '/bin/bash', 08:45:19 INFO - 'SHLVL': '1', 08:45:19 INFO - 'TERM': 'linux', 08:45:19 INFO - 'TMOUT': '86400', 08:45:19 INFO - 'USER': 'cltbld', 08:45:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:19 INFO - '_': '/tools/buildbot/bin/python'} 08:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:19 INFO - Downloading/unpacking psutil>=3.1.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:20 INFO - Installing collected packages: psutil 08:45:20 INFO - Running setup.py install for psutil 08:45:20 INFO - building 'psutil._psutil_linux' extension 08:45:20 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 08:45:20 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 08:45:20 INFO - building 'psutil._psutil_posix' extension 08:45:20 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 08:45:21 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 08:45:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:21 INFO - Successfully installed psutil 08:45:21 INFO - Cleaning up... 08:45:21 INFO - Return code: 0 08:45:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:21 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')]} 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:21 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')]} 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:21 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 08:45:21 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 08:45:21 INFO - Using env: {'DISPLAY': ':0', 08:45:21 INFO - 'HOME': '/home/cltbld', 08:45:21 INFO - 'LANG': 'en_US.UTF-8', 08:45:21 INFO - 'LANGUAGE': 'en_US:en', 08:45:21 INFO - 'LOGNAME': 'cltbld', 08:45:21 INFO - 'MAIL': '/var/mail/cltbld', 08:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:21 INFO - 'MOZ_NO_REMOTE': '1', 08:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:21 INFO - 'NO_EM_RESTART': '1', 08:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:21 INFO - 'PWD': '/builds/slave/test', 08:45:21 INFO - 'SHELL': '/bin/bash', 08:45:21 INFO - 'SHLVL': '1', 08:45:21 INFO - 'TERM': 'linux', 08:45:21 INFO - 'TMOUT': '86400', 08:45:21 INFO - 'USER': 'cltbld', 08:45:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:21 INFO - '_': '/tools/buildbot/bin/python'} 08:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:22 INFO - Installing collected packages: mozsystemmonitor 08:45:22 INFO - Running setup.py install for mozsystemmonitor 08:45:22 INFO - Successfully installed mozsystemmonitor 08:45:22 INFO - Cleaning up... 08:45:22 INFO - Return code: 0 08:45:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:22 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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:22 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 08:45:22 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 08:45:22 INFO - Using env: {'DISPLAY': ':0', 08:45:22 INFO - 'HOME': '/home/cltbld', 08:45:22 INFO - 'LANG': 'en_US.UTF-8', 08:45:22 INFO - 'LANGUAGE': 'en_US:en', 08:45:22 INFO - 'LOGNAME': 'cltbld', 08:45:22 INFO - 'MAIL': '/var/mail/cltbld', 08:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:22 INFO - 'MOZ_NO_REMOTE': '1', 08:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:22 INFO - 'NO_EM_RESTART': '1', 08:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:22 INFO - 'PWD': '/builds/slave/test', 08:45:22 INFO - 'SHELL': '/bin/bash', 08:45:22 INFO - 'SHLVL': '1', 08:45:22 INFO - 'TERM': 'linux', 08:45:22 INFO - 'TMOUT': '86400', 08:45:22 INFO - 'USER': 'cltbld', 08:45:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:22 INFO - '_': '/tools/buildbot/bin/python'} 08:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:22 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:22 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 08:45:22 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 08:45:22 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 08:45:22 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 08:45:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:23 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 08:45:23 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 08:45:23 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 08:45:23 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 08:45:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:24 INFO - warning: no files found matching '*.txt' 08:45:24 INFO - no previously-included directories found matching 'build' 08:45:24 INFO - no previously-included directories found matching 'dist' 08:45:24 INFO - no previously-included directories found matching '.git*' 08:45:24 INFO - Installing collected packages: jsonschema, functools32 08:45:24 INFO - Running setup.py install for functools32 08:45:24 INFO - warning: no files found matching '*.txt' 08:45:24 INFO - no previously-included directories found matching 'build' 08:45:24 INFO - no previously-included directories found matching 'dist' 08:45:24 INFO - no previously-included directories found matching '.git*' 08:45:24 INFO - Successfully installed jsonschema functools32 08:45:24 INFO - Cleaning up... 08:45:24 INFO - Return code: 0 08:45:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:24 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')]} 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:24 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')]} 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:24 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 08:45:24 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 08:45:24 INFO - Using env: {'DISPLAY': ':0', 08:45:24 INFO - 'HOME': '/home/cltbld', 08:45:24 INFO - 'LANG': 'en_US.UTF-8', 08:45:24 INFO - 'LANGUAGE': 'en_US:en', 08:45:24 INFO - 'LOGNAME': 'cltbld', 08:45:24 INFO - 'MAIL': '/var/mail/cltbld', 08:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:24 INFO - 'MOZ_NO_REMOTE': '1', 08:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:24 INFO - 'NO_EM_RESTART': '1', 08:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:24 INFO - 'PWD': '/builds/slave/test', 08:45:24 INFO - 'SHELL': '/bin/bash', 08:45:24 INFO - 'SHLVL': '1', 08:45:24 INFO - 'TERM': 'linux', 08:45:24 INFO - 'TMOUT': '86400', 08:45:24 INFO - 'USER': 'cltbld', 08:45:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:24 INFO - '_': '/tools/buildbot/bin/python'} 08:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:24 INFO - Cleaning up... 08:45:24 INFO - Return code: 0 08:45:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:24 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')]} 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:24 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')]} 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:24 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 08:45:24 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 08:45:24 INFO - Using env: {'DISPLAY': ':0', 08:45:24 INFO - 'HOME': '/home/cltbld', 08:45:24 INFO - 'LANG': 'en_US.UTF-8', 08:45:24 INFO - 'LANGUAGE': 'en_US:en', 08:45:24 INFO - 'LOGNAME': 'cltbld', 08:45:24 INFO - 'MAIL': '/var/mail/cltbld', 08:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:24 INFO - 'MOZ_NO_REMOTE': '1', 08:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:24 INFO - 'NO_EM_RESTART': '1', 08:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:24 INFO - 'PWD': '/builds/slave/test', 08:45:24 INFO - 'SHELL': '/bin/bash', 08:45:24 INFO - 'SHLVL': '1', 08:45:24 INFO - 'TERM': 'linux', 08:45:24 INFO - 'TMOUT': '86400', 08:45:24 INFO - 'USER': 'cltbld', 08:45:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:24 INFO - '_': '/tools/buildbot/bin/python'} 08:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - Downloading docopt-0.6.1.tar.gz 08:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:26 INFO - Running setup.py install for blobuploader 08:45:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:26 INFO - Running setup.py install for requests 08:45:26 INFO - Running setup.py install for docopt 08:45:27 INFO - Successfully installed blobuploader requests docopt 08:45:27 INFO - Cleaning up... 08:45:27 INFO - Return code: 0 08:45:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:27 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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:27 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 08:45:27 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 08:45:27 INFO - Using env: {'DISPLAY': ':0', 08:45:27 INFO - 'HOME': '/home/cltbld', 08:45:27 INFO - 'LANG': 'en_US.UTF-8', 08:45:27 INFO - 'LANGUAGE': 'en_US:en', 08:45:27 INFO - 'LOGNAME': 'cltbld', 08:45:27 INFO - 'MAIL': '/var/mail/cltbld', 08:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:27 INFO - 'MOZ_NO_REMOTE': '1', 08:45:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:27 INFO - 'NO_EM_RESTART': '1', 08:45:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:27 INFO - 'PWD': '/builds/slave/test', 08:45:27 INFO - 'SHELL': '/bin/bash', 08:45:27 INFO - 'SHLVL': '1', 08:45:27 INFO - 'TERM': 'linux', 08:45:27 INFO - 'TMOUT': '86400', 08:45:27 INFO - 'USER': 'cltbld', 08:45:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:27 INFO - '_': '/tools/buildbot/bin/python'} 08:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:27 INFO - Running setup.py (path:/tmp/pip-NDDRyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:27 INFO - Running setup.py (path:/tmp/pip-4P1KY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:27 INFO - Running setup.py (path:/tmp/pip-Bx2mOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:27 INFO - Running setup.py (path:/tmp/pip-mxVhsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:27 INFO - Running setup.py (path:/tmp/pip-eCG7f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:27 INFO - Running setup.py (path:/tmp/pip-gYwQWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:27 INFO - Running setup.py (path:/tmp/pip-kr8URq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:27 INFO - Running setup.py (path:/tmp/pip-AxLbPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:27 INFO - Running setup.py (path:/tmp/pip-tuPuPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:27 INFO - Running setup.py (path:/tmp/pip-MWyxhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:28 INFO - Running setup.py (path:/tmp/pip-uf0xYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:28 INFO - Running setup.py (path:/tmp/pip-HAXLdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:28 INFO - Running setup.py (path:/tmp/pip-Yh_nvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:28 INFO - Running setup.py (path:/tmp/pip-TXAoQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:28 INFO - Running setup.py (path:/tmp/pip-G3xk0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:28 INFO - Running setup.py (path:/tmp/pip-27jalJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:28 INFO - Running setup.py (path:/tmp/pip-JyzcOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:28 INFO - Running setup.py install for manifestparser 08:45:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozcrash 08:45:28 INFO - Running setup.py install for mozdebug 08:45:28 INFO - Running setup.py install for mozdevice 08:45:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozfile 08:45:29 INFO - Running setup.py install for mozhttpd 08:45:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozinfo 08:45:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozInstall 08:45:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozleak 08:45:29 INFO - Running setup.py install for mozlog 08:45:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for moznetwork 08:45:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozprocess 08:45:29 INFO - Running setup.py install for mozprofile 08:45:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:30 INFO - Running setup.py install for mozrunner 08:45:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:30 INFO - Running setup.py install for mozscreenshot 08:45:30 INFO - Running setup.py install for moztest 08:45:30 INFO - Running setup.py install for mozversion 08:45:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:30 INFO - Cleaning up... 08:45:30 INFO - Return code: 0 08:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:30 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')]} 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:30 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')]} 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:30 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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:30 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 08:45:30 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 08:45:30 INFO - Using env: {'DISPLAY': ':0', 08:45:30 INFO - 'HOME': '/home/cltbld', 08:45:30 INFO - 'LANG': 'en_US.UTF-8', 08:45:30 INFO - 'LANGUAGE': 'en_US:en', 08:45:30 INFO - 'LOGNAME': 'cltbld', 08:45:30 INFO - 'MAIL': '/var/mail/cltbld', 08:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:30 INFO - 'MOZ_NO_REMOTE': '1', 08:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:30 INFO - 'NO_EM_RESTART': '1', 08:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:30 INFO - 'PWD': '/builds/slave/test', 08:45:30 INFO - 'SHELL': '/bin/bash', 08:45:30 INFO - 'SHLVL': '1', 08:45:30 INFO - 'TERM': 'linux', 08:45:30 INFO - 'TMOUT': '86400', 08:45:30 INFO - 'USER': 'cltbld', 08:45:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:30 INFO - '_': '/tools/buildbot/bin/python'} 08:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:30 INFO - Running setup.py (path:/tmp/pip-gLDSUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:30 INFO - Running setup.py (path:/tmp/pip-4aReLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:30 INFO - Running setup.py (path:/tmp/pip-4nTiNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:30 INFO - Running setup.py (path:/tmp/pip-eq0XEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:30 INFO - Running setup.py (path:/tmp/pip-2lHH2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:31 INFO - Running setup.py (path:/tmp/pip-5SDThl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:31 INFO - Running setup.py (path:/tmp/pip-ueFD3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:31 INFO - Running setup.py (path:/tmp/pip-jAFon0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:31 INFO - Running setup.py (path:/tmp/pip-M4qrdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:31 INFO - Running setup.py (path:/tmp/pip-RKHrJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:31 INFO - Running setup.py (path:/tmp/pip-Cljs0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:31 INFO - Running setup.py (path:/tmp/pip-i_ULf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:31 INFO - Running setup.py (path:/tmp/pip-IOKw0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:31 INFO - Running setup.py (path:/tmp/pip-OW1v6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:31 INFO - Running setup.py (path:/tmp/pip-PAeY_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:31 INFO - Running setup.py (path:/tmp/pip-3adz_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:31 INFO - Running setup.py (path:/tmp/pip-c0Yvf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:31 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 08:45:31 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 08:45:31 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 08:45:31 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 08:45:33 INFO - Downloading blessings-1.6.tar.gz 08:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:33 INFO - Installing collected packages: blessings 08:45:33 INFO - Running setup.py install for blessings 08:45:33 INFO - Successfully installed blessings 08:45:33 INFO - Cleaning up... 08:45:33 INFO - Return code: 0 08:45:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:33 INFO - Reading from file tmpfile_stdout 08:45:33 INFO - Current package versions: 08:45:33 INFO - argparse == 1.2.1 08:45:33 INFO - blessings == 1.6 08:45:33 INFO - blobuploader == 1.2.4 08:45:33 INFO - docopt == 0.6.1 08:45:33 INFO - functools32 == 3.2.3-2 08:45:33 INFO - jsonschema == 2.5.1 08:45:33 INFO - manifestparser == 1.1 08:45:33 INFO - mozInstall == 1.12 08:45:33 INFO - mozcrash == 1.0 08:45:33 INFO - mozdebug == 0.1 08:45:33 INFO - mozdevice == 0.50 08:45:33 INFO - mozfile == 1.2 08:45:33 INFO - mozhttpd == 0.7 08:45:33 INFO - mozinfo == 0.9 08:45:33 INFO - mozleak == 0.1 08:45:33 INFO - mozlog == 3.4 08:45:33 INFO - moznetwork == 0.27 08:45:33 INFO - mozprocess == 0.25 08:45:33 INFO - mozprofile == 0.28 08:45:33 INFO - mozrunner == 6.13 08:45:33 INFO - mozscreenshot == 0.1 08:45:33 INFO - mozsystemmonitor == 0.3 08:45:33 INFO - moztest == 0.8 08:45:33 INFO - mozversion == 1.4 08:45:33 INFO - psutil == 3.1.1 08:45:33 INFO - requests == 1.2.3 08:45:33 INFO - wsgiref == 0.1.2 08:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:33 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')]} 08:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:33 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')]} 08:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:33 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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:33 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 08:45:33 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 08:45:33 INFO - Using env: {'DISPLAY': ':0', 08:45:33 INFO - 'HOME': '/home/cltbld', 08:45:33 INFO - 'LANG': 'en_US.UTF-8', 08:45:33 INFO - 'LANGUAGE': 'en_US:en', 08:45:33 INFO - 'LOGNAME': 'cltbld', 08:45:33 INFO - 'MAIL': '/var/mail/cltbld', 08:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:33 INFO - 'MOZ_NO_REMOTE': '1', 08:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:33 INFO - 'NO_EM_RESTART': '1', 08:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:33 INFO - 'PWD': '/builds/slave/test', 08:45:33 INFO - 'SHELL': '/bin/bash', 08:45:33 INFO - 'SHLVL': '1', 08:45:33 INFO - 'TERM': 'linux', 08:45:33 INFO - 'TMOUT': '86400', 08:45:33 INFO - 'USER': 'cltbld', 08:45:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:33 INFO - '_': '/tools/buildbot/bin/python'} 08:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 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)) 08:45:33 INFO - Cleaning up... 08:45:33 INFO - Return code: 0 08:45:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:33 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')]} 08:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:33 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')]} 08:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:33 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 0x22f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, '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': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', '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 08:45:33 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 08:45:33 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 08:45:33 INFO - Using env: {'DISPLAY': ':0', 08:45:33 INFO - 'HOME': '/home/cltbld', 08:45:33 INFO - 'LANG': 'en_US.UTF-8', 08:45:33 INFO - 'LANGUAGE': 'en_US:en', 08:45:33 INFO - 'LOGNAME': 'cltbld', 08:45:33 INFO - 'MAIL': '/var/mail/cltbld', 08:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:33 INFO - 'MOZ_NO_REMOTE': '1', 08:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:33 INFO - 'NO_EM_RESTART': '1', 08:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:33 INFO - 'PWD': '/builds/slave/test', 08:45:33 INFO - 'SHELL': '/bin/bash', 08:45:33 INFO - 'SHLVL': '1', 08:45:33 INFO - 'TERM': 'linux', 08:45:33 INFO - 'TMOUT': '86400', 08:45:33 INFO - 'USER': 'cltbld', 08:45:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:33 INFO - '_': '/tools/buildbot/bin/python'} 08:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:33 INFO - Cleaning up... 08:45:33 INFO - Return code: 0 08:45:33 INFO - Running post-action listener: _resource_record_post_action 08:45:33 INFO - Running post-action listener: _start_resource_monitoring 08:45:33 INFO - Starting resource monitoring. 08:45:33 INFO - [mozharness: 2017-05-17 15:45:33.947060Z] Finished create-virtualenv step (success) 08:45:33 INFO - [mozharness: 2017-05-17 15:45:33.947564Z] Running install step. 08:45:33 INFO - Running pre-action listener: _resource_record_pre_action 08:45:33 INFO - Running main action method: install 08:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:34 INFO - Reading from file tmpfile_stdout 08:45:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:34 INFO - Reading from file tmpfile_stdout 08:45:34 INFO - Output received: 08:45:34 INFO - Usage: mozinstall [options] installer 08:45:34 INFO - Options: 08:45:34 INFO - -h, --help show this help message and exit 08:45:34 INFO - -d DEST, --destination=DEST 08:45:34 INFO - Directory to install application into. [default: 08:45:34 INFO - "/builds/slave/test"] 08:45:34 INFO - --app=APP Application being installed. [default: firefox] 08:45:34 INFO - mkdir: /builds/slave/test/build/application 08:45:34 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'] 08:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:45:50 INFO - Reading from file tmpfile_stdout 08:45:50 INFO - Output received: 08:45:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:50 INFO - Running post-action listener: _resource_record_post_action 08:45:50 INFO - [mozharness: 2017-05-17 15:45:50.150326Z] Finished install step (success) 08:45:50 INFO - [mozharness: 2017-05-17 15:45:50.150480Z] Running run-tests step. 08:45:50 INFO - Running pre-action listener: _resource_record_pre_action 08:45:50 INFO - Running main action method: run_tests 08:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:50 INFO - Python 2.7.3 08:45:50 INFO - Return code: 0 08:45:50 INFO - grabbing minidump binary from tooltool 08:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:50 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 0x26697a0>, '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 0x266a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266ab30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:50 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 08:45:50 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 08:45:50 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 08:45:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:50 INFO - Return code: 0 08:45:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:50 INFO - ENV: RUST_BACKTRACE is now 1 08:45:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:50 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/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 08:45:50 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/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 08:45:50 INFO - Using env: {'DISPLAY': ':0', 08:45:50 INFO - 'HOME': '/home/cltbld', 08:45:50 INFO - 'LANG': 'en_US.UTF-8', 08:45:50 INFO - 'LANGUAGE': 'en_US:en', 08:45:50 INFO - 'LOGNAME': 'cltbld', 08:45:50 INFO - 'MAIL': '/var/mail/cltbld', 08:45:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:50 INFO - 'MOZ_NO_REMOTE': '1', 08:45:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:50 INFO - 'NO_EM_RESTART': '1', 08:45:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:50 INFO - 'PWD': '/builds/slave/test', 08:45:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:50 INFO - 'RUST_BACKTRACE': '1', 08:45:50 INFO - 'SHELL': '/bin/bash', 08:45:50 INFO - 'SHLVL': '1', 08:45:50 INFO - 'TERM': 'linux', 08:45:50 INFO - 'TMOUT': '86400', 08:45:50 INFO - 'USER': 'cltbld', 08:45:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801', 08:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:50 INFO - '_': '/tools/buildbot/bin/python'} 08:45:50 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/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 08:45:50 INFO - mozversion application_buildid: 20170517151202 08:45:50 INFO - mozversion application_changeset: 85e5d15c31691c89b82d6068c26260416493071f 08:45:50 INFO - mozversion application_display_name: Nightly 08:45:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:50 INFO - mozversion application_name: Firefox 08:45:50 INFO - mozversion application_remotingname: firefox 08:45:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:45:50 INFO - mozversion application_vendor: Mozilla 08:45:50 INFO - mozversion application_version: 55.0a1 08:45:50 INFO - mozversion platform_buildid: 20170517151202 08:45:50 INFO - mozversion platform_changeset: 85e5d15c31691c89b82d6068c26260416493071f 08:45:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:45:50 INFO - mozversion platform_version: 55.0a1 08:45:50 INFO - using testdate: 1495035950 08:45:50 INFO - actual date: 1495035950 08:45:50 INFO - starting webserver on 'localhost:59029' 08:45:50 INFO - SUITE-START | Running 2 tests 08:45:50 INFO - TEST-START | dromaeo_css 08:45:50 INFO - operating with platform_type : linux_ 08:45:50 INFO - Initialising browser for dromaeo_css test... 08:45:50 INFO - TEST-INFO | started process 13783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCk_9Mj/profile http://localhost:59029/getInfo.html) 08:45:50 INFO - PID 13783 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 08:45:54 INFO - PID 13783 | __metrics Screen width/height:1600/1200 08:45:54 INFO - PID 13783 | colorDepth:24 08:45:54 INFO - PID 13783 | Browser inner width/height: 1024/695 08:45:54 INFO - PID 13783 | __metrics 08:45:56 INFO - TEST-INFO | 13783: exit 0 08:45:56 INFO - Browser initialized. 08:45:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:56 INFO - TEST-INFO | started process 13951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCk_9Mj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:08 INFO - PID 13951 | RSS: Main: 161865728 08:46:08 INFO - PID 13951 | 08:49:13 INFO - PID 13951 | Cycle 1(1): loaded http://localhost:59029/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59029/tests/dromaeo/cssquery-ext.html) 08:49:15 INFO - PID 13951 | RSS: Main: 168144896 08:49:15 INFO - PID 13951 | 08:52:17 INFO - PID 13951 | Cycle 1(1): loaded http://localhost:59029/tests/dromaeo/cssquery-ext.html (next: http://localhost:59029/tests/dromaeo/cssquery-jquery.html) 08:52:17 INFO - PID 13951 | RSS: Main: 166662144 08:52:17 INFO - PID 13951 | 08:55:19 INFO - PID 13951 | Cycle 1(1): loaded http://localhost:59029/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59029/tests/dromaeo/cssquery-mootools.html) 08:55:20 INFO - PID 13951 | RSS: Main: 168689664 08:55:20 INFO - PID 13951 | 08:58:22 INFO - PID 13951 | Cycle 1(1): loaded http://localhost:59029/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59029/tests/dromaeo/cssquery-prototype.html) 08:58:22 INFO - PID 13951 | RSS: Main: 166907904 08:58:22 INFO - PID 13951 | 09:01:25 INFO - PID 13951 | Cycle 1(1): loaded http://localhost:59029/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59029/tests/dromaeo/cssquery-yui.html) 09:01:26 INFO - PID 13951 | RSS: Main: 167579648 09:01:26 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | Cycle 1(1): loaded http://localhost:59029/tests/dromaeo/cssquery-yui.html (next: http://localhost:59029/tests/dromaeo/cssquery-dojo.html) 09:04:28 INFO - PID 13951 | RSS: Main: 174800896 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | __start_tp_report 09:04:28 INFO - PID 13951 | _x_x_mozilla_page_load 09:04:28 INFO - PID 13951 | _x_x_mozilla_page_load_details 09:04:28 INFO - PID 13951 | |i|pagename|runs| 09:04:28 INFO - PID 13951 | |0;dojo.html;2735.0837469447733;2763.3920537481745;2765.0598796409217;2794.552871540554;2802.1645821986594;5342.0651386007485;5358.892822143554;5392.110301800208;5417.431169727181;5451.727413629323;5387.326584176978;5388.272583201267;5420.728963551826;5486.094794358936;5503.174523821429;4788.6887352322165;4811.35046768687;4819.325294458778;4842.394700662418;4872.4640289568115;4821.517848215186;4870.586000189988;4908.116539022974;4918.827841025565;4954.430240522332;4756.310335001405;4803.1114243864995;4842.612590992748;4862.44081930579;4911.263310503436;4808.422989241279;4822.517748225185;4842.104210721028;4863.221884498499;4875.756212189376;4710.199266124733;4778.856634300976;4792.808287668489;4798.568128868384;4853.757312134415;5245.501677340685;5381.784728610851;5384.030874442598;5432.375276843174;5440.374356948962;5831.737571809279;5835.212246346731;5904.498117660004;5911.586188966774;5929.1995580596495;5884.764609415618;5884.9705751470965;5892.116182572606;5901.439363260483;5905.793297234619;5441.945580544144;5444.972775136099;5464.535514481234;5471.124620060851;5484;5944.108383742387;6005.099235114768;6011.0382338825575;6024.8795024100145;6036.547258955508;5702.030654788696;5723.54211663066;5737.942620573825;5747.339056008613;5785.1611516329895;5778.479936805707;5850.47345738877;5854.824355269348;5884.411558844081;5884.47039766423;5784.161296611967;5796.333421656564;5801.071828507503;5810.50610698087;5822.5633077518505;5794.88410231793;5794.913076303858;5801.419858014165;5824.301083869963;5827.3298570664065;4768.451628062748;4811.807527698923;4838.491958344393;4872.220444728827;4886.364772579542;4149.730267532601;4159.438475805788;4161.8335266589;4198.118395136994;4213.6207741302815;4979.925301120486;4988.002399520038;4990.575801056878;4992.201247800334;5032.521910418504;5790.478856902899;5842.766289348378;5880.558958078162;5894.734736936848;5897.823065308047;4986.900261994812;5004.099262132851;5016.698998060128;5017.89964200714;5042.193249080129;5185.974070129625;5193.792248310101;5199.766010529535;5202.97398513005;5234.26720259164;5334;5369.060414427381;5425.240466334637;5456.590755693418;5476.069068258326;5882.970585147047;5903.055511118372;5908.911366329423;5943.286805583358;5966.791162309299;5334.919976200283;5433.375161856437;5450.209719590716;5450.454954504517;5476.397596264328;5764.048931926185;5797.594168408171;5837.328707198726;5872.882542349043;5876.735546900314;5790.681512516683;5845.1232315153065;5850.180974663635;5853.09277062056;5884.352721200579;5622.100463925753;5656.717164141859;5697.031504644303;5712.857178570569;5713.200151978644;5642.266505354278;5707.600467967202;5718.571107167062;5726.198332233407;5730.742116604846;5510.641808282448;5554.111342185231;5582.078956972054;5597.552195824405;5613.073842815889;5608.10270356741;5683.7442315095095;5715.685637289989;5720.713964301685;5727.198192253005;5498.3127109111365;5508.862278443071;5556.138798486241;5571.303587051619;5586 09:04:28 INFO - PID 13951 | |1;ext.html;686.6498085976153;747.4543583184276;762.0778857582325;1061.1457776489922;1070.9464526773659;31526;32743;33012.83493582532;33090.99999999997;33092.66907330926;34027.829860850725;34236.65763342366;34305.48541771875;34415;34572.13569660753;6860.6912688929115;6904.827379315532;7011.649417529103;7022.789316320519;7074.22183559808;7096.645167741618;7148.356647901688;7156.069710937571;7182.928170718278;7204.063471748692;7171.318724721144;7216.943171196184;7231.240719724432;7239.312265334811;7242.311980361857;7133.5363201392265;7168.103987001625;7198.172210195842;7203.279672032781;7211.314925082109;6687.933120668828;6701.832454188636;6707.664616769142;6708.83227919301;6712.630805305706;31483.84258078695;31644.525332120036;31658.683413165803;31688.683113169034;31812.522812157604;2698.7840972722133;2720.7687346575567;2745.2999485131363;2749.2439579115703;2756.2007017964766;24567.14015009466;24623.138190163438;24783.25650230496;24905.87547062253;24937.875310623513;3078.2304423894025;3079.476488996876;3084.4447999360104;3110.284634534047;3146.65386807451;139656;141017.2949135258;143774;145430.27284863614;146727;39016;39343;39505.20989580192;39533.80233098816;39559;40838.59161408407;41186.38220426696;41227.587724122975;41354.793226033675;41370.79314603468;11868.64394068162;11915.2255103418;11968.10239232061;11993.760124797454;12040.518379264906;9454.621815127319;9493.335466517416;9526.85709714355;9549.140577347933;9551.331406801597;12439;12474.126811123135;12496.68758281032;12522.499100035897;12750.234985900875;5186.351706036746;5254.737263136828;5265.6840589564745;5341.287804975583;5348.304720386325;863.9827203455895;907.4509921497531;914.8947870994921;915.4415806358116;934.953252337394;20729.68905466419;21168.930505076987;21222.151113955268;21298.893505532375;21713.78286217149;962.5860879821744;973.6738192705523;990.8414653655525;992.6773798515511;997.5860018092555;10947.34315941046;11068.114550835913;11252.831207531894;11350.659480215607;11530.135239857043;151203;154206.22896885668;154427;154928;173833;44070;44202.23191072385;44282.77858610751;44510;44809.10381792346;1185.271058299157;1205.7889869272842;1207.565276500459;1212.508933881797;1228.791105512065;23922.641160382955;24327.148549800673;25225.117120901414;25263.24210273621;25303.74696253014;29424.705752942198;29631.85184074066;29757.851210743807;29779;29831.403371932873;151031;151264.2436787809;151283;151401.2429937843;151657;28618.42763144767;28718.569221462112;28723.425531489673;30300.69699302979;30325.241868953453;35591.11022224465;35952.82023589865;36001.27997440089;36092.63907360893;36411.27177456489;26113;27066;27163.456730864877;28134.49848024388;28427;26806;27433.31416714598;28061.438771224053;28465.857670712343;28872;29995.55006674858;30339.393212135194;30494.237644059074;31936;32264.516032259064;27025.1892443227;27431.725682742916;27521;27693.446131077668;28685.28286792847;21539.676904846125;22649.2072777452;22788.544229115658;22915.312540623807;22975.540489190458 09:04:28 INFO - PID 13951 | |2;jquery.html;416.25905887520224;417.6867349487884;420.6928941872433;435.91717573661003;439.973601583905;15081.849181508182;17150.14249287535;17916.283348666053;17926.37257695981;18028.63942721145;17932.82067179331;18069.548261293476;18113.456596302098;18250.726239106425;18252.543686407847;5360.973195134019;5375.7849686012705;5551.3893471718075;5563.582731295169;5614.719264036802;5403.7027963462;5510.531604813596;5519.172124181365;5528.198411230369;5533.833984980437;5369.892602147955;5456.699881506535;5489.58828087893;5500.1749737539285;5567;4788.904221915577;4793.5925446337105;4817.277408388734;4822.541858523435;4835.419749630049;4367.619647292202;4396.472423309191;4997.9750101249265;5003.349564556621;5032.798688052473;21338.46653833651;21718.782812171834;21748;21859;22075.558488830135;1593.4184022831698;1629.8696104311746;1642.0886408043532;1644.3587001069593;1645.2514106081824;14047.22740249286;14425.278736063156;14800.629984250372;14819.851801481955;14900.62748431287;1973.2501649373146;2059.794020597928;2061.072517367176;2070.523779530701;2079.7712251652306;82509.58745206296;85386;86333.56833215794;86344;88833.55583222107;10733.463326833627;11011.504482298316;11021;11079.778404431867;11160.553577856796;13590.728185436235;15201.391944322104;15241;15363;15378.3079761411;7403.185649578542;7404.555726656418;7422.257774222642;7664;7672.079350477979;6648.53460257787;6661.367170118831;6922.203946546211;6937.895931561031;6952.860942781217;7072.186698529735;7145.499445116479;7166.78499645001;7175.31834475724;7184.317489838457;1866.3281218761235;1909.9427017189507;1922.9615407691767;1931.1792488192461;2109.535902101535;832.8542505061711;860.3891237221643;862.7498025572513;870.7561882672735;884.195382202193;16434.506964791075;16773.6645267094;17094.316227351017;17185.226664800113;17409.651806964044;870.5864714260675;873.8907636545432;883.9337049721297;898.4609234459402;901.6348378906554;8853.51305678181;9208.90791092094;9441.716748497556;9511.762205944768;9573.90426095744;340304;342890;343504;344170;345064;69866.65066674634;70594;70828;70885;73001.6349918247;1010.46409457624;1051.8264486359665;1052.9628316108626;1124.241137232365;1135.0975974100445;16659.416920407726;17029.148542573068;17417.82582174162;17895.910520447316;17946.28214871443;38320.42519362268;39803.40294895521;40265;40377.596224037385;40625.79687101545;49377.259341109195;49445.752771235915;49456.25815612841;49514.50485495099;51260.74369628128;7691.30778229962;7882.09355924076;8261.669533218605;8296.751097467086;8773.674976131459;11294.548218071513;12229.449674764835;12511.056363718224;12624.810627840407;12761.170523915916;10901.127909767041;11020.44897755093;11027.393493357942;11132.499037543492;11229.382383968634;10009.799804004026;10453;10455.634052808115;10505;10589.152867770714;11053.914390242742;11123.443827808416;11204.383758893338;11513.136514761594;11553.884461155618;11849.940750296193;12011.939940300243;12013.219140755822;12101.576444824388;12479.563215287784;10481.266311358437;10974.615888443866;11158.88841111611;11307.265027773168;11776.4700588472 09:04:28 INFO - PID 13951 | |3;mootools.html;1228.588422878336;1295.397640097354;1296.4814074370252;1298.3183828490035;1299.9999999999998;10044.949775251123;10505.31715438496;10565.049145576906;10573.101286390656;10708.357498550093;10626.468676566179;10708.73228169296;10754.247202695815;10808.837867431976;10811.135109191266;2137.1665050630227;2173.6630822222583;2181.6073106840763;2183.061283648031;2188.5513469738744;2158.2877650375417;2201.6587428948537;2204.4599073227;2209.4034610655112;2214.878181700006;2220.2673117871145;2226.476777957179;2245.3264020793777;2252.876091814958;2270.12600148943;2120.130746393979;2129.9467513312215;2150.1291976749285;2151.7310336207975;2156.762756096828;2114.5770845830893;2173.119886445992;2229.5429436965383;2244.932652020442;2250.0437314141423;10144.594216231342;10201.540930658064;10207.13239374654;10214;10219.233557483218;5601.103823388279;5831.09618009205;5834.97082514589;5835.416458354173;5837.066069428871;3082.645495767993;3192.154079169022;3264.7061764441078;3309.7848639838576;3387.627360990289;983.961920174216;1005.8440941654055;1012.6405126180174;1064.4571268652965;1084.7179733269327;15352.07887526752;15360.385584576716;15428;15478.767818482731;15524.223788810514;4624.699394539344;4835.117500501718;4879.56083952446;4960.0327936052845;4965.528274813887;10885.945570272257;10890.727731806768;10970.561177552809;10975.121990240921;10976.12191024716;5688.943110568841;5722.399148089474;5726.169705392778;5737.168110623936;5738.971305143447;5138.691678499302;5284.7803922352705;5313.229581710631;5324.334458192726;5383.461653834585;3641.708663306929;3754.2679177560112;3803.1823158021157;3825.1502630540426;3855.903602409906;1061.2783307351076;1066.941318227505;1068.503146037081;1082.3289560472558;1084.5065495199665;666.7866282789557;684.555039224498;690.3234829866759;696.7422053840011;707.8478127202676;5121.257417674491;5166.095933211673;5254.5533629641905;5417.972910135503;5455.236266922634;537.3095572189717;543.3968295192333;554.6450271826035;554.7115499940089;555.0536335547881;3202.6637203093806;3223.854926528312;3356.594730176065;3582.946255806165;3630.674803696632;12067.155299129152;12886;12894.48422063107;12898.871011289955;12938.288394138224;12694.80957785634;12891;13538.187708737507;13797.172169669851;13810.10234334765;7762.340201082971;7792.103908050533;7805.765827025199;7900.644470998819;7913.208679132156;5500.312460942382;5515.365732940602;5564.165375193753;5587.0502014656795;5691.943080569141;11579.247348922294;11914.702132446411;11953.282803031845;12155.574554890536;12172;12420;12427;12506.499740010298;12532.498700051896;12679.302638354979;7510.211427800003;7614.238576142341;8036.919630803617;8389.370797190113;8401.369897257608;9868.901310987085;9946.104850563484;9985;10007.649732259337;10043.89956100459;8138.430309878252;8313.792155196168;8454.196851299117;8576.785580360542;8642.178992995656;8020.799480013046;8054.275115239657;8163.428560000743;8189.795255118432;8238.794030149294;7013.193482749549;7138.571685698875;7139.785806425815;7143.214246432992;7158;4889.315495830516;5037.874053148701;5051.393832740095;5095.566876815512;5318.441563635763;4985.675931064469;5086.440491545853;5125.8718532037;5173.715445650525;5183.248428977852 09:04:28 INFO - PID 13951 | |4;prototype.html;356.03159406414545;356.20566137513345;364.2587334773736;365.51934206518433;372.1997704934391;5472.26124473196;5511.641743286684;5558.499735023847;5567.638103523268;5622.718864056791;5381.838544843661;5513.641613295143;5514.558835293177;5516.779328826842;5539.362973258077;4175.248455278049;4289.978550107245;4299.742015479065;4305.634021108194;4326.480822301328;4289.1636130954475;4292.570742925698;4297.333913243452;4310.719803212797;4324.091940692459;4270.081932384553;4283.971846756772;4285.742855428684;4285.892852678677;4295.914081718363;4160.6061969240345;4274.3543735662;4288.935665965013;4327.632151267146;4346.1090476452255;3863.4011728181895;3882.63115004077;3886.6113388661192;3890.8832735017713;3911.3155197840265;5411.594130440233;5420.105682562373;5427.565794736451;5437.673739575638;5451.918221226685;4980.526849949249;5145.536901678867;5178.300929374562;5180.248863914749;5196.2465442511;5909.320428150775;5924.881502369928;5937.426581955785;5950.018246989242;5957.6127551709;4407.471103467572;4418.977905110454;4429.6899217054815;4445.222086134913;4450.5104438511735;6139.508839292846;6262.060690896356;6292.696334424464;6305.117283580303;6344.841378965562;4461.330800379969;4485.730856148642;4495.865124046284;4496.752678602708;4515.029268707243;4503.617192538605;4571.817127314936;4573.679842410999;4586.908261834811;4593.724376537419;5085.415177254663;5089.541941225308;5098.770555324945;5120.1039818031695;5129.410117836422;5915.911261331084;5946.345901950782;5947.9702601486715;5949.196858424058;5958.136070269873;1545.3586761493855;1593.219322531951;1599.6880608281274;1621.1488968291505;1624.4801663467813;1082.5453309609982;1113.7549739057395;1115.760111576015;1124.859392575928;1143.7369405036889;5013.037093277701;5076.923846142311;5078.390593128848;5081.161608334583;5104.106781313255;6053.364396738367;6060.696965151725;6078.422549857756;6094.695265236721;6098.69506524672;4923.759689341341;4971.850844474671;5093.363329583802;5106.4382917879;5143.819966301162;3194.329190869897;3204.5193221017034;3231.321422501254;3236.7086962173516;3245.8863939761995;5443.972780136153;5616.410276920946;5620.91568626471;5630.71846407678;5642.125470551989;6001.259634705973;6212.415833962311;6261.655608941552;6273.37266273369;6292.8426789329715;5611.354694210137;5619.241402410704;5625.437456254342;5638.041532939328;5658.462446067617;6019.72911219005;6102.664353460602;6106.511479081574;6123.418275263843;6124.703236286393;6002.669853158118;6012.488938440107;6049.062395328731;6056.45491905713;6081.361457047124;5665;5667.433256674464;5674;5675.68783716883;5689.317281926195;4005.4792876925812;4009.1179940413062;4011.1777085696776;4037.9596204037584;4051.3207245631343;6124.54065945047;6150.35421280777;6164.321924588202;6169.84575385619;6180.6291622502795;5864.472197502075;5893.852653683693;5925.4370834770625;5934.7922822701;5935.465808077293;5725.513331366714;5854.619449735754;5880.529867533117;5932.822015339547;5942;5811.82564523065;5812.476877081083;5820.330661973758;5828.76684932598;5836.474717275466;5789.1605717171615;5897.970510147422;5934.050551911673;5942.524598032233;5964.4492431968865;5735.541156707537;5741.100744124191;5758.531574448489;5762.049261871744;5767.942320576741 09:04:28 INFO - PID 13951 | |5;yui.html;729.9781006569805;750.8122969257682;751.4589495563195;756.4137793210261;766.9616519174042;10684.732881677963;11357.034652054565;12556.748865022693;13522.188668679873;13572.253526056074;13895.652608684788;14093.154410735337;14663.486777962773;14675.633109172277;14743.26283685814;858.78530367408;880.995595022024;883.6642076011107;884.5577211394303;886.6630680341461;895.1138373010705;900.1628485508475;903.8373092843285;904.2494729374636;905.1265528764741;928.8049509602957;938.3431597881477;939.3002213351028;941.2470023980823;945.1304799584365;925.8148370325928;927.9814403711922;932.7901222225013;940.962361505539;941.9670311539097;686.9038334633156;690.7858563845224;692.6882902693758;693.639307560066;695.2526034512869;12606.810897836449;12829.807552886714;13024.218546887218;13687.657808554766;13784.724305513833;14546.418143274257;14583;14652.633684157874;14766.630834229123;14969.326380312912;12333.321667308295;12519.12366134371;12521.56174533896;12582.119251652388;12706.428210730539;2925.3417980954328;2956.1870485616414;2959.2453924249394;2970.1386597886585;2971.6582593001867;58897.41102588962;59370.10944835831;60632;61146.08280875791;63107;12370.257784532956;12618.873811261954;12711.745765084646;12748.745025099446;12758.617241482585;18482.445526634223;18920.33778817735;18951.241950321833;18956.409834348415;18967.43097707071;5787.623804452697;6018.488428483628;6025.548083893726;6035.698215089228;6178.505719542426;2751.5735061065566;2835.036087730182;2849.9857500712365;2853.657561092682;2866.154484427099;3081.245094951751;3158.1788734928623;3168.588083549124;3190.888318908827;3784.3377408953875;731.3417923868561;747.200495469853;748.7379417203935;750.4521699159644;751.2412463411994;563.4056070845215;570.4438172781505;578.4764787866987;578.9478946894716;598.2850493660121;9746.75633109178;9925.2059835213;10697.83953240702;11016.889831101586;11178.664640060648;598.7724664627501;606.121124369657;610.9786157484556;618.6226401894841;624.2820756130395;4364.170807546556;4526.140033393711;4530.932036019462;4549.977250113729;4569.109023740339;59790;60974.39025609687;62241.377586223556;63877.36122638714;64237;54785.1782223267;55238;55332.72333638306;56884.43115568791;58087;49659.503404965486;49802.25296620554;49972.50027499751;50315.24527132096;51296.99999999925;9461.905380946102;9500.144986951207;9567.521623918637;9643.180329671775;9878.654247101316;26442.07452739222;27272.181834544994;27333.72666273312;27392;27521.449571008066;31244;32297.51553726743;32298.515522266716;32566.83716581402;33430;12082.75834483323;12149.75700486003;12304.446299916704;12498.312592807482;12499.500019999097;12736.299503527394;12893.871061289266;12973.805392918925;13091.738165236451;13309.800352994907;11536.480858361561;11893.405329733305;11906.642800715992;11977.64067077989;12009.579664711693;13062.804057938949;13298.268595227355;13554.390052447467;13730;13973;14172.574822755334;15484.380624774883;15903.443379481663;16229.59426014359;16415;9539.189168920442;9959.751006224902;10821.621243256763;10836.566537338418;11180.776384472427;10992.17558683086;11398.658040258806;11488.597899073493;11553.711157221136;11563.537458501565 09:04:28 INFO - PID 13951 | __end_tp_report 09:04:28 INFO - PID 13951 | __start_cc_report 09:04:28 INFO - PID 13951 | _x_x_mozilla_cycle_collect,300 09:04:28 INFO - PID 13951 | __end_cc_report 09:04:28 INFO - PID 13951 | __startTimestamp1495037068511__endTimestamp 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | ------- Summary: start ------- 09:04:28 INFO - PID 13951 | Number of tests: 6 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | [#0] dojo.html Cycles:165 Average:5343.13 Median:5484.00 stddev:636.03 (11.6%) stddev-sans-first:604.18 09:04:28 INFO - PID 13951 | Values: 2735.1 2763.4 2765.1 2794.6 2802.2 5342.1 5358.9 5392.1 5417.4 5451.7 5387.3 5388.3 5420.7 5486.1 5503.2 4788.7 4811.4 4819.3 4842.4 4872.5 4821.5 4870.6 4908.1 4918.8 4954.4 4756.3 4803.1 4842.6 4862.4 4911.3 4808.4 4822.5 4842.1 4863.2 4875.8 4710.2 4778.9 4792.8 4798.6 4853.8 5245.5 5381.8 5384.0 5432.4 5440.4 5831.7 5835.2 5904.5 5911.6 5929.2 5884.8 5885.0 5892.1 5901.4 5905.8 5441.9 5445.0 5464.5 5471.1 5484.0 5944.1 6005.1 6011.0 6024.9 6036.5 5702.0 5723.5 5737.9 5747.3 5785.2 5778.5 5850.5 5854.8 5884.4 5884.5 5784.2 5796.3 5801.1 5810.5 5822.6 5794.9 5794.9 5801.4 5824.3 5827.3 4768.5 4811.8 4838.5 4872.2 4886.4 4149.7 4159.4 4161.8 4198.1 4213.6 4979.9 4988.0 4990.6 4992.2 5032.5 5790.5 5842.8 5880.6 5894.7 5897.8 4986.9 5004.1 5016.7 5017.9 5042.2 5186.0 5193.8 5199.8 5203.0 5234.3 5334.0 5369.1 5425.2 5456.6 5476.1 5883.0 5903.1 5908.9 5943.3 5966.8 5334.9 5433.4 5450.2 5450.5 5476.4 5764.0 5797.6 5837.3 5872.9 5876.7 5790.7 5845.1 5850.2 5853.1 5884.4 5622.1 5656.7 5697.0 5712.9 5713.2 5642.3 5707.6 5718.6 5726.2 5730.7 5510.6 5554.1 5582.1 5597.6 5613.1 5608.1 5683.7 5715.7 5720.7 5727.2 5498.3 5508.9 5556.1 5571.3 5586.0 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | [#1] ext.html Cycles:180 Average:29831.59 Median:3078.85 stddev:38881.63 (1262.9%) stddev-sans-first:38929.11 09:04:28 INFO - PID 13951 | Values: 686.6 747.5 762.1 1061.1 1070.9 31526.0 32743.0 33012.8 33091.0 33092.7 34027.8 34236.7 34305.5 34415.0 34572.1 6860.7 6904.8 7011.6 7022.8 7074.2 7096.6 7148.4 7156.1 7182.9 7204.1 7171.3 7216.9 7231.2 7239.3 7242.3 7133.5 7168.1 7198.2 7203.3 7211.3 6687.9 6701.8 6707.7 6708.8 6712.6 31483.8 31644.5 31658.7 31688.7 31812.5 2698.8 2720.8 2745.3 2749.2 2756.2 24567.1 24623.1 24783.3 24905.9 24937.9 3078.2 3079.5 3084.4 3110.3 3146.7 139656.0 141017.3 143774.0 145430.3 146727.0 39016.0 39343.0 39505.2 39533.8 39559.0 40838.6 41186.4 41227.6 41354.8 41370.8 11868.6 11915.2 11968.1 11993.8 12040.5 9454.6 9493.3 9526.9 9549.1 9551.3 12439.0 12474.1 12496.7 12522.5 12750.2 5186.4 5254.7 5265.7 5341.3 5348.3 864.0 907.5 914.9 915.4 935.0 20729.7 21168.9 21222.2 21298.9 21713.8 962.6 973.7 990.8 992.7 997.6 10947.3 11068.1 11252.8 11350.7 11530.1 151203.0 154206.2 154427.0 154928.0 173833.0 44070.0 44202.2 44282.8 44510.0 44809.1 1185.3 1205.8 1207.6 1212.5 1228.8 23922.6 24327.1 25225.1 25263.2 25303.7 29424.7 29631.9 29757.9 29779.0 29831.4 151031.0 151264.2 151283.0 151401.2 151657.0 28618.4 28718.6 28723.4 30300.7 30325.2 35591.1 35952.8 36001.3 36092.6 36411.3 26113.0 27066.0 27163.5 28134.5 28427.0 26806.0 27433.3 28061.4 28465.9 28872.0 29995.6 30339.4 30494.2 31936.0 32264.5 27025.2 27431.7 27521.0 27693.4 28685.3 21539.7 22649.2 22788.5 22915.3 22975.5 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | [#2] jquery.html Cycles:180 Average:23999.47 Median:341597.00 stddev:57175.23 (16.7%) stddev-sans-first:57308.21 09:04:28 INFO - PID 13951 | Values: 416.3 417.7 420.7 435.9 440.0 15081.8 17150.1 17916.3 17926.4 18028.6 17932.8 18069.5 18113.5 18250.7 18252.5 5361.0 5375.8 5551.4 5563.6 5614.7 5403.7 5510.5 5519.2 5528.2 5533.8 5369.9 5456.7 5489.6 5500.2 5567.0 4788.9 4793.6 4817.3 4822.5 4835.4 4367.6 4396.5 4998.0 5003.3 5032.8 21338.5 21718.8 21748.0 21859.0 22075.6 1593.4 1629.9 1642.1 1644.4 1645.3 14047.2 14425.3 14800.6 14819.9 14900.6 1973.3 2059.8 2061.1 2070.5 2079.8 82509.6 85386.0 86333.6 86344.0 88833.6 10733.5 11011.5 11021.0 11079.8 11160.6 13590.7 15201.4 15241.0 15363.0 15378.3 7403.2 7404.6 7422.3 7664.0 7672.1 6648.5 6661.4 6922.2 6937.9 6952.9 7072.2 7145.5 7166.8 7175.3 7184.3 1866.3 1909.9 1923.0 1931.2 2109.5 832.9 860.4 862.7 870.8 884.2 16434.5 16773.7 17094.3 17185.2 17409.7 870.6 873.9 883.9 898.5 901.6 8853.5 9208.9 9441.7 9511.8 9573.9 340304.0 342890.0 343504.0 344170.0 345064.0 69866.7 70594.0 70828.0 70885.0 73001.6 1010.5 1051.8 1053.0 1124.2 1135.1 16659.4 17029.1 17417.8 17895.9 17946.3 38320.4 39803.4 40265.0 40377.6 40625.8 49377.3 49445.8 49456.3 49514.5 51260.7 7691.3 7882.1 8261.7 8296.8 8773.7 11294.5 12229.4 12511.1 12624.8 12761.2 10901.1 11020.4 11027.4 11132.5 11229.4 10009.8 10453.0 10455.6 10505.0 10589.2 11053.9 11123.4 11204.4 11513.1 11553.9 11849.9 12011.9 12013.2 12101.6 12479.6 10481.3 10974.6 11158.9 11307.3 11776.5 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | [#3] mootools.html Cycles:180 Average:6292.03 Median:3287.25 stddev:4122.46 (125.4%) stddev-sans-first:4116.47 09:04:28 INFO - PID 13951 | Values: 1228.6 1295.4 1296.5 1298.3 1300.0 10044.9 10505.3 10565.0 10573.1 10708.4 10626.5 10708.7 10754.2 10808.8 10811.1 2137.2 2173.7 2181.6 2183.1 2188.6 2158.3 2201.7 2204.5 2209.4 2214.9 2220.3 2226.5 2245.3 2252.9 2270.1 2120.1 2129.9 2150.1 2151.7 2156.8 2114.6 2173.1 2229.5 2244.9 2250.0 10144.6 10201.5 10207.1 10214.0 10219.2 5601.1 5831.1 5835.0 5835.4 5837.1 3082.6 3192.2 3264.7 3309.8 3387.6 984.0 1005.8 1012.6 1064.5 1084.7 15352.1 15360.4 15428.0 15478.8 15524.2 4624.7 4835.1 4879.6 4960.0 4965.5 10885.9 10890.7 10970.6 10975.1 10976.1 5688.9 5722.4 5726.2 5737.2 5739.0 5138.7 5284.8 5313.2 5324.3 5383.5 3641.7 3754.3 3803.2 3825.2 3855.9 1061.3 1066.9 1068.5 1082.3 1084.5 666.8 684.6 690.3 696.7 707.8 5121.3 5166.1 5254.6 5418.0 5455.2 537.3 543.4 554.6 554.7 555.1 3202.7 3223.9 3356.6 3582.9 3630.7 12067.2 12886.0 12894.5 12898.9 12938.3 12694.8 12891.0 13538.2 13797.2 13810.1 7762.3 7792.1 7805.8 7900.6 7913.2 5500.3 5515.4 5564.2 5587.1 5691.9 11579.2 11914.7 11953.3 12155.6 12172.0 12420.0 12427.0 12506.5 12532.5 12679.3 7510.2 7614.2 8036.9 8389.4 8401.4 9868.9 9946.1 9985.0 10007.6 10043.9 8138.4 8313.8 8454.2 8576.8 8642.2 8020.8 8054.3 8163.4 8189.8 8238.8 7013.2 7138.6 7139.8 7143.2 7158.0 4889.3 5037.9 5051.4 5095.6 5318.4 4985.7 5086.4 5125.9 5173.7 5183.2 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | [#4] prototype.html Cycles:180 Average:4904.23 Median:5447.95 stddev:1411.22 (25.9%) stddev-sans-first:1373.27 09:04:28 INFO - PID 13951 | Values: 356.0 356.2 364.3 365.5 372.2 5472.3 5511.6 5558.5 5567.6 5622.7 5381.8 5513.6 5514.6 5516.8 5539.4 4175.2 4290.0 4299.7 4305.6 4326.5 4289.2 4292.6 4297.3 4310.7 4324.1 4270.1 4284.0 4285.7 4285.9 4295.9 4160.6 4274.4 4288.9 4327.6 4346.1 3863.4 3882.6 3886.6 3890.9 3911.3 5411.6 5420.1 5427.6 5437.7 5451.9 4980.5 5145.5 5178.3 5180.2 5196.2 5909.3 5924.9 5937.4 5950.0 5957.6 4407.5 4419.0 4429.7 4445.2 4450.5 6139.5 6262.1 6292.7 6305.1 6344.8 4461.3 4485.7 4495.9 4496.8 4515.0 4503.6 4571.8 4573.7 4586.9 4593.7 5085.4 5089.5 5098.8 5120.1 5129.4 5915.9 5946.3 5948.0 5949.2 5958.1 1545.4 1593.2 1599.7 1621.1 1624.5 1082.5 1113.8 1115.8 1124.9 1143.7 5013.0 5076.9 5078.4 5081.2 5104.1 6053.4 6060.7 6078.4 6094.7 6098.7 4923.8 4971.9 5093.4 5106.4 5143.8 3194.3 3204.5 3231.3 3236.7 3245.9 5444.0 5616.4 5620.9 5630.7 5642.1 6001.3 6212.4 6261.7 6273.4 6292.8 5611.4 5619.2 5625.4 5638.0 5658.5 6019.7 6102.7 6106.5 6123.4 6124.7 6002.7 6012.5 6049.1 6056.5 6081.4 5665.0 5667.4 5674.0 5675.7 5689.3 4005.5 4009.1 4011.2 4038.0 4051.3 6124.5 6150.4 6164.3 6169.8 6180.6 5864.5 5893.9 5925.4 5934.8 5935.5 5725.5 5854.6 5880.5 5932.8 5942.0 5811.8 5812.5 5820.3 5828.8 5836.5 5789.2 5898.0 5934.1 5942.5 5964.4 5735.5 5741.1 5758.5 5762.0 5767.9 09:04:28 INFO - PID 13951 | 09:04:28 INFO - PID 13951 | [#5] yui.html Cycles:180 Average:14508.41 Median:17744.20 stddev:16942.05 (95.5%) stddev-sans-first:16957.98 09:04:28 INFO - PID 13951 | Values: 730.0 750.8 751.5 756.4 767.0 10684.7 11357.0 12556.7 13522.2 13572.3 13895.7 14093.2 14663.5 14675.6 14743.3 858.8 881.0 883.7 884.6 886.7 895.1 900.2 903.8 904.2 905.1 928.8 938.3 939.3 941.2 945.1 925.8 928.0 932.8 941.0 942.0 686.9 690.8 692.7 693.6 695.3 12606.8 12829.8 13024.2 13687.7 13784.7 14546.4 14583.0 14652.6 14766.6 14969.3 12333.3 12519.1 12521.6 12582.1 12706.4 2925.3 2956.2 2959.2 2970.1 2971.7 58897.4 59370.1 60632.0 61146.1 63107.0 12370.3 12618.9 12711.7 12748.7 12758.6 18482.4 18920.3 18951.2 18956.4 18967.4 5787.6 6018.5 6025.5 6035.7 6178.5 2751.6 2835.0 2850.0 2853.7 2866.2 3081.2 3158.2 3168.6 3190.9 3784.3 731.3 747.2 748.7 750.5 751.2 563.4 570.4 578.5 578.9 598.3 9746.8 9925.2 10697.8 11016.9 11178.7 598.8 606.1 611.0 618.6 624.3 4364.2 4526.1 4530.9 4550.0 4569.1 59790.0 60974.4 62241.4 63877.4 64237.0 54785.2 55238.0 55332.7 56884.4 58087.0 49659.5 49802.3 49972.5 50315.2 51297.0 9461.9 9500.1 9567.5 9643.2 9878.7 26442.1 27272.2 27333.7 27392.0 27521.4 31244.0 32297.5 32298.5 32566.8 33430.0 12082.8 12149.8 12304.4 12498.3 12499.5 12736.3 12893.9 12973.8 13091.7 13309.8 11536.5 11893.4 11906.6 11977.6 12009.6 13062.8 13298.3 13554.4 13730.0 13973.0 14172.6 15484.4 15903.4 16229.6 16415.0 9539.2 9959.8 10821.6 10836.6 11180.8 10992.2 11398.7 11488.6 11553.7 11563.5 09:04:28 INFO - PID 13951 | -------- Summary: end -------- 09:04:28 INFO - PID 13951 | 09:04:29 INFO - TEST-INFO | 13951: exit 0 09:04:29 INFO - TEST-OK | dromaeo_css | took 1118935ms 09:04:29 INFO - TEST-START | kraken 09:04:29 INFO - operating with platform_type : linux_ 09:04:29 INFO - Initialising browser for kraken test... 09:04:29 INFO - TEST-INFO | started process 14369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTHKd6I/profile http://localhost:59029/getInfo.html) 09:04:29 INFO - PID 14369 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:04:33 INFO - PID 14369 | __metrics Screen width/height:1600/1200 09:04:33 INFO - PID 14369 | colorDepth:24 09:04:33 INFO - PID 14369 | Browser inner width/height: 1024/695 09:04:33 INFO - PID 14369 | __metrics 09:04:35 INFO - TEST-INFO | 14369: exit 0 09:04:35 INFO - Browser initialized. 09:04:35 INFO - Running cycle 1/1 for kraken test... 09:04:35 INFO - TEST-INFO | started process 14542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTHKd6I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:46 INFO - PID 14542 | RSS: Main: 161357824 09:04:46 INFO - PID 14542 | 09:04:49 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59029/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:50 INFO - PID 14542 | RSS: Main: 167288832 09:04:50 INFO - PID 14542 | 09:04:53 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59029/tests/kraken/driver.html?testName=audio-dft) 09:04:53 INFO - PID 14542 | RSS: Main: 166584320 09:04:53 INFO - PID 14542 | 09:04:56 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59029/tests/kraken/driver.html?testName=audio-fft) 09:04:57 INFO - PID 14542 | RSS: Main: 161873920 09:04:57 INFO - PID 14542 | 09:04:59 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59029/tests/kraken/driver.html?testName=audio-oscillator) 09:05:00 INFO - PID 14542 | RSS: Main: 163008512 09:05:00 INFO - PID 14542 | 09:05:02 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59029/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:02 INFO - PID 14542 | RSS: Main: 162811904 09:05:02 INFO - PID 14542 | 09:05:05 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59029/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:06 INFO - PID 14542 | RSS: Main: 167067648 09:05:06 INFO - PID 14542 | 09:05:10 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59029/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:10 INFO - PID 14542 | RSS: Main: 164634624 09:05:10 INFO - PID 14542 | 09:05:13 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59029/tests/kraken/driver.html?testName=json-parse-financial) 09:05:14 INFO - PID 14542 | RSS: Main: 164958208 09:05:14 INFO - PID 14542 | 09:05:15 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59029/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:16 INFO - PID 14542 | RSS: Main: 165150720 09:05:16 INFO - PID 14542 | 09:05:18 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:18 INFO - PID 14542 | RSS: Main: 165634048 09:05:18 INFO - PID 14542 | 09:05:21 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:21 INFO - PID 14542 | RSS: Main: 165232640 09:05:21 INFO - PID 14542 | 09:05:24 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:25 INFO - PID 14542 | RSS: Main: 165961728 09:05:25 INFO - PID 14542 | 09:05:28 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:29 INFO - PID 14542 | RSS: Main: 165429248 09:05:29 INFO - PID 14542 | 09:05:30 INFO - PID 14542 | Cycle 1(1): loaded http://localhost:59029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59029/tests/kraken/driver.html?testName=ai-astar) 09:05:31 INFO - PID 14542 | RSS: Main: 166514688 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | __start_tp_report 09:05:31 INFO - PID 14542 | _x_x_mozilla_page_load 09:05:31 INFO - PID 14542 | _x_x_mozilla_page_load_details 09:05:31 INFO - PID 14542 | |i|pagename|runs| 09:05:31 INFO - PID 14542 | |0;ai-astar;105;114;113;111;112;111;111;113;111;112 09:05:31 INFO - PID 14542 | |1;audio-beat-detection;155;124;125;184;125;125;124;125;147;124 09:05:31 INFO - PID 14542 | |2;audio-dft;163;164;163;163;164;167;169;169;166;166 09:05:31 INFO - PID 14542 | |3;audio-fft;75;75;75;100;75;75;75;75;106;76 09:05:31 INFO - PID 14542 | |4;audio-oscillator;84;83;105;84;83;83;98;83;83;104 09:05:31 INFO - PID 14542 | |5;imaging-gaussian-blur;114;114;114;115;115;114;114;114;115;115 09:05:31 INFO - PID 14542 | |6;imaging-darkroom;150;150;151;152;150;151;150;151;150;151 09:05:31 INFO - PID 14542 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;95 09:05:31 INFO - PID 14542 | |8;json-parse-financial;59;57;58;56;65;55;58;55;55;56 09:05:31 INFO - PID 14542 | |9;json-stringify-tinderbox;56;56;56;55;55;55;58;55;56;56 09:05:31 INFO - PID 14542 | |10;stanford-crypto-aes;84;82;82;83;83;88;82;82;89;82 09:05:31 INFO - PID 14542 | |11;stanford-crypto-ccm;148;133;132;132;134;139;142;133;183;131 09:05:31 INFO - PID 14542 | |12;stanford-crypto-pbkdf2;195;198;196;191;201;196;194;185;192;193 09:05:31 INFO - PID 14542 | |13;stanford-crypto-sha256-iterative;76;75;82;74;81;74;73;72;80;73 09:05:31 INFO - PID 14542 | __end_tp_report 09:05:31 INFO - PID 14542 | __start_cc_report 09:05:31 INFO - PID 14542 | _x_x_mozilla_cycle_collect,801 09:05:31 INFO - PID 14542 | __end_cc_report 09:05:31 INFO - PID 14542 | __startTimestamp1495037131098__endTimestamp 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | ------- Summary: start ------- 09:05:31 INFO - PID 14542 | Number of tests: 14 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.45 (2.2%) stddev-sans-first:1.12 09:05:31 INFO - PID 14542 | Values: 105.0 114.0 113.0 111.0 112.0 111.0 111.0 113.0 111.0 112.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:125.00 stddev:20.28 (16.2%) stddev-sans-first:20.29 09:05:31 INFO - PID 14542 | Values: 155.0 124.0 125.0 184.0 125.0 125.0 124.0 125.0 147.0 124.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:2.37 (1.4%) stddev-sans-first:2.35 09:05:31 INFO - PID 14542 | Values: 163.0 164.0 163.0 163.0 164.0 167.0 169.0 169.0 166.0 166.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.84 (15.8%) stddev-sans-first:12.38 09:05:31 INFO - PID 14542 | Values: 75.0 75.0 75.0 100.0 75.0 75.0 75.0 75.0 106.0 76.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.00 stddev:9.38 (11.3%) stddev-sans-first:9.77 09:05:31 INFO - PID 14542 | Values: 84.0 83.0 105.0 84.0 83.0 83.0 98.0 83.0 83.0 104.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:05:31 INFO - PID 14542 | Values: 114.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 115.0 115.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:05:31 INFO - PID 14542 | Values: 150.0 150.0 151.0 152.0 150.0 151.0 150.0 151.0 150.0 151.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:05:31 INFO - PID 14542 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:3.03 (5.3%) stddev-sans-first:3.15 09:05:31 INFO - PID 14542 | Values: 59.0 57.0 58.0 56.0 65.0 55.0 58.0 55.0 55.0 56.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 09:05:31 INFO - PID 14542 | Values: 56.0 56.0 56.0 55.0 55.0 55.0 58.0 55.0 56.0 56.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.63 (3.2%) stddev-sans-first:2.78 09:05:31 INFO - PID 14542 | Values: 84.0 82.0 82.0 83.0 83.0 88.0 82.0 82.0 89.0 82.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:136.50 stddev:15.83 (11.6%) stddev-sans-first:16.57 09:05:31 INFO - PID 14542 | Values: 148.0 133.0 132.0 132.0 134.0 139.0 142.0 133.0 183.0 131.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.10 Median:195.50 stddev:4.33 (2.2%) stddev-sans-first:4.58 09:05:31 INFO - PID 14542 | Values: 195.0 198.0 196.0 191.0 201.0 196.0 194.0 185.0 192.0 193.0 09:05:31 INFO - PID 14542 | 09:05:31 INFO - PID 14542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:75.50 stddev:3.65 (4.8%) stddev-sans-first:3.87 09:05:31 INFO - PID 14542 | Values: 76.0 75.0 82.0 74.0 81.0 74.0 73.0 72.0 80.0 73.0 09:05:31 INFO - PID 14542 | -------- Summary: end -------- 09:05:31 INFO - PID 14542 | 09:05:32 INFO - TEST-INFO | 14542: exit 0 09:05:32 INFO - TEST-OK | kraken | took 62884ms 09:05:32 INFO - SUITE-END | took 1181s 09:05:32 INFO - Completed test suite (00:19:42) 09:05:32 INFO - javascript benchmark 09:05:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6729.859451644413, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2735.0837469447733, 2763.3920537481745, 2765.0598796409217, 2794.552871540554, 2802.1645821986594, 5342.0651386007485, 5358.892822143554, 5392.110301800208, 5417.431169727181, 5451.727413629323, 5387.326584176978, 5388.272583201267, 5420.728963551826, 5486.094794358936, 5503.174523821429, 4788.6887352322165, 4811.35046768687, 4819.325294458778, 4842.394700662418, 4872.4640289568115, 4821.517848215186, 4870.586000189988, 4908.116539022974, 4918.827841025565, 4954.430240522332, 4756.310335001405, 4803.1114243864995, 4842.612590992748, 4862.44081930579, 4911.263310503436, 4808.422989241279, 4822.517748225185, 4842.104210721028, 4863.221884498499, 4875.756212189376, 4710.199266124733, 4778.856634300976, 4792.808287668489, 4798.568128868384, 4853.757312134415, 5245.501677340685, 5381.784728610851, 5384.030874442598, 5432.375276843174, 5440.374356948962, 5831.737571809279, 5835.212246346731, 5904.498117660004, 5911.586188966774, 5929.1995580596495, 5884.764609415618, 5884.9705751470965, 5892.116182572606, 5901.439363260483, 5905.793297234619, 5441.945580544144, 5444.972775136099, 5464.535514481234, 5471.124620060851, 5484.0, 5944.108383742387, 6005.099235114768, 6011.0382338825575, 6024.8795024100145, 6036.547258955508, 5702.030654788696, 5723.54211663066, 5737.942620573825, 5747.339056008613, 5785.1611516329895, 5778.479936805707, 5850.47345738877, 5854.824355269348, 5884.411558844081, 5884.47039766423, 5784.161296611967, 5796.333421656564, 5801.071828507503, 5810.50610698087, 5822.5633077518505, 5794.88410231793, 5794.913076303858, 5801.419858014165, 5824.301083869963, 5827.3298570664065, 4768.451628062748, 4811.807527698923, 4838.491958344393, 4872.220444728827, 4886.364772579542, 4149.730267532601, 4159.438475805788, 4161.8335266589, 4198.118395136994, 4213.6207741302815, 4979.925301120486, 4988.002399520038, 4990.575801056878, 4992.201247800334, 5032.521910418504, 5790.478856902899, 5842.766289348378, 5880.558958078162, 5894.734736936848, 5897.823065308047, 4986.900261994812, 5004.099262132851, 5016.698998060128, 5017.89964200714, 5042.193249080129, 5185.974070129625, 5193.792248310101, 5199.766010529535, 5202.97398513005, 5234.26720259164, 5334.0, 5369.060414427381, 5425.240466334637, 5456.590755693418, 5476.069068258326, 5882.970585147047, 5903.055511118372, 5908.911366329423, 5943.286805583358, 5966.791162309299, 5334.919976200283, 5433.375161856437, 5450.209719590716, 5450.454954504517, 5476.397596264328, 5764.048931926185, 5797.594168408171, 5837.328707198726, 5872.882542349043, 5876.735546900314, 5790.681512516683, 5845.1232315153065, 5850.180974663635, 5853.09277062056, 5884.352721200579, 5622.100463925753, 5656.717164141859, 5697.031504644303, 5712.857178570569, 5713.200151978644, 5642.266505354278, 5707.600467967202, 5718.571107167062, 5726.198332233407, 5730.742116604846, 5510.641808282448, 5554.111342185231, 5582.078956972054, 5597.552195824405, 5613.073842815889, 5608.10270356741, 5683.7442315095095, 5715.685637289989, 5720.713964301685, 5727.198192253005, 5498.3127109111365, 5508.862278443071, 5556.138798486241, 5571.303587051619, 5586.0], "value": 5295.820920138441, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.6498085976153, 747.4543583184276, 762.0778857582325, 1061.1457776489922, 1070.9464526773659, 31526.0, 32743.0, 33012.83493582532, 33090.99999999997, 33092.66907330926, 34027.829860850725, 34236.65763342366, 34305.48541771875, 34415.0, 34572.13569660753, 6860.6912688929115, 6904.827379315532, 7011.649417529103, 7022.789316320519, 7074.22183559808, 7096.645167741618, 7148.356647901688, 7156.069710937571, 7182.928170718278, 7204.063471748692, 7171.318724721144, 7216.943171196184, 7231.240719724432, 7239.312265334811, 7242.311980361857, 7133.5363201392265, 7168.103987001625, 7198.172210195842, 7203.279672032781, 7211.314925082109, 6687.933120668828, 6701.832454188636, 6707.664616769142, 6708.83227919301, 6712.630805305706, 31483.84258078695, 31644.525332120036, 31658.683413165803, 31688.683113169034, 31812.522812157604, 2698.7840972722133, 2720.7687346575567, 2745.2999485131363, 2749.2439579115703, 2756.2007017964766, 24567.14015009466, 24623.138190163438, 24783.25650230496, 24905.87547062253, 24937.875310623513, 3078.2304423894025, 3079.476488996876, 3084.4447999360104, 3110.284634534047, 3146.65386807451, 139656.0, 141017.2949135258, 143774.0, 145430.27284863614, 146727.0, 39016.0, 39343.0, 39505.20989580192, 39533.80233098816, 39559.0, 40838.59161408407, 41186.38220426696, 41227.587724122975, 41354.793226033675, 41370.79314603468, 11868.64394068162, 11915.2255103418, 11968.10239232061, 11993.760124797454, 12040.518379264906, 9454.621815127319, 9493.335466517416, 9526.85709714355, 9549.140577347933, 9551.331406801597, 12439.0, 12474.126811123135, 12496.68758281032, 12522.499100035897, 12750.234985900875, 5186.351706036746, 5254.737263136828, 5265.6840589564745, 5341.287804975583, 5348.304720386325, 863.9827203455895, 907.4509921497531, 914.8947870994921, 915.4415806358116, 934.953252337394, 20729.68905466419, 21168.930505076987, 21222.151113955268, 21298.893505532375, 21713.78286217149, 962.5860879821744, 973.6738192705523, 990.8414653655525, 992.6773798515511, 997.5860018092555, 10947.34315941046, 11068.114550835913, 11252.831207531894, 11350.659480215607, 11530.135239857043, 151203.0, 154206.22896885668, 154427.0, 154928.0, 173833.0, 44070.0, 44202.23191072385, 44282.77858610751, 44510.0, 44809.10381792346, 1185.271058299157, 1205.7889869272842, 1207.565276500459, 1212.508933881797, 1228.791105512065, 23922.641160382955, 24327.148549800673, 25225.117120901414, 25263.24210273621, 25303.74696253014, 29424.705752942198, 29631.85184074066, 29757.851210743807, 29779.0, 29831.403371932873, 151031.0, 151264.2436787809, 151283.0, 151401.2429937843, 151657.0, 28618.42763144767, 28718.569221462112, 28723.425531489673, 30300.69699302979, 30325.241868953453, 35591.11022224465, 35952.82023589865, 36001.27997440089, 36092.63907360893, 36411.27177456489, 26113.0, 27066.0, 27163.456730864877, 28134.49848024388, 28427.0, 26806.0, 27433.31416714598, 28061.438771224053, 28465.857670712343, 28872.0, 29995.55006674858, 30339.393212135194, 30494.237644059074, 31936.0, 32264.516032259064, 27025.1892443227, 27431.725682742916, 27521.0, 27693.446131077668, 28685.28286792847, 21539.676904846125, 22649.2072777452, 22788.544229115658, 22915.312540623807, 22975.540489190458], "value": 14482.741239640807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.25905887520224, 417.6867349487884, 420.6928941872433, 435.91717573661003, 439.973601583905, 15081.849181508182, 17150.14249287535, 17916.283348666053, 17926.37257695981, 18028.63942721145, 17932.82067179331, 18069.548261293476, 18113.456596302098, 18250.726239106425, 18252.543686407847, 5360.973195134019, 5375.7849686012705, 5551.3893471718075, 5563.582731295169, 5614.719264036802, 5403.7027963462, 5510.531604813596, 5519.172124181365, 5528.198411230369, 5533.833984980437, 5369.892602147955, 5456.699881506535, 5489.58828087893, 5500.1749737539285, 5567.0, 4788.904221915577, 4793.5925446337105, 4817.277408388734, 4822.541858523435, 4835.419749630049, 4367.619647292202, 4396.472423309191, 4997.9750101249265, 5003.349564556621, 5032.798688052473, 21338.46653833651, 21718.782812171834, 21748.0, 21859.0, 22075.558488830135, 1593.4184022831698, 1629.8696104311746, 1642.0886408043532, 1644.3587001069593, 1645.2514106081824, 14047.22740249286, 14425.278736063156, 14800.629984250372, 14819.851801481955, 14900.62748431287, 1973.2501649373146, 2059.794020597928, 2061.072517367176, 2070.523779530701, 2079.7712251652306, 82509.58745206296, 85386.0, 86333.56833215794, 86344.0, 88833.55583222107, 10733.463326833627, 11011.504482298316, 11021.0, 11079.778404431867, 11160.553577856796, 13590.728185436235, 15201.391944322104, 15241.0, 15363.0, 15378.3079761411, 7403.185649578542, 7404.555726656418, 7422.257774222642, 7664.0, 7672.079350477979, 6648.53460257787, 6661.367170118831, 6922.203946546211, 6937.895931561031, 6952.860942781217, 7072.186698529735, 7145.499445116479, 7166.78499645001, 7175.31834475724, 7184.317489838457, 1866.3281218761235, 1909.9427017189507, 1922.9615407691767, 1931.1792488192461, 2109.535902101535, 832.8542505061711, 860.3891237221643, 862.7498025572513, 870.7561882672735, 884.195382202193, 16434.506964791075, 16773.6645267094, 17094.316227351017, 17185.226664800113, 17409.651806964044, 870.5864714260675, 873.8907636545432, 883.9337049721297, 898.4609234459402, 901.6348378906554, 8853.51305678181, 9208.90791092094, 9441.716748497556, 9511.762205944768, 9573.90426095744, 340304.0, 342890.0, 343504.0, 344170.0, 345064.0, 69866.65066674634, 70594.0, 70828.0, 70885.0, 73001.6349918247, 1010.46409457624, 1051.8264486359665, 1052.9628316108626, 1124.241137232365, 1135.0975974100445, 16659.416920407726, 17029.148542573068, 17417.82582174162, 17895.910520447316, 17946.28214871443, 38320.42519362268, 39803.40294895521, 40265.0, 40377.596224037385, 40625.79687101545, 49377.259341109195, 49445.752771235915, 49456.25815612841, 49514.50485495099, 51260.74369628128, 7691.30778229962, 7882.09355924076, 8261.669533218605, 8296.751097467086, 8773.674976131459, 11294.548218071513, 12229.449674764835, 12511.056363718224, 12624.810627840407, 12761.170523915916, 10901.127909767041, 11020.44897755093, 11027.393493357942, 11132.499037543492, 11229.382383968634, 10009.799804004026, 10453.0, 10455.634052808115, 10505.0, 10589.152867770714, 11053.914390242742, 11123.443827808416, 11204.383758893338, 11513.136514761594, 11553.884461155618, 11849.940750296193, 12011.939940300243, 12013.219140755822, 12101.576444824388, 12479.563215287784, 10481.266311358437, 10974.615888443866, 11158.88841111611, 11307.265027773168, 11776.4700588472], "value": 8809.600355551147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.588422878336, 1295.397640097354, 1296.4814074370252, 1298.3183828490035, 1299.9999999999998, 10044.949775251123, 10505.31715438496, 10565.049145576906, 10573.101286390656, 10708.357498550093, 10626.468676566179, 10708.73228169296, 10754.247202695815, 10808.837867431976, 10811.135109191266, 2137.1665050630227, 2173.6630822222583, 2181.6073106840763, 2183.061283648031, 2188.5513469738744, 2158.2877650375417, 2201.6587428948537, 2204.4599073227, 2209.4034610655112, 2214.878181700006, 2220.2673117871145, 2226.476777957179, 2245.3264020793777, 2252.876091814958, 2270.12600148943, 2120.130746393979, 2129.9467513312215, 2150.1291976749285, 2151.7310336207975, 2156.762756096828, 2114.5770845830893, 2173.119886445992, 2229.5429436965383, 2244.932652020442, 2250.0437314141423, 10144.594216231342, 10201.540930658064, 10207.13239374654, 10214.0, 10219.233557483218, 5601.103823388279, 5831.09618009205, 5834.97082514589, 5835.416458354173, 5837.066069428871, 3082.645495767993, 3192.154079169022, 3264.7061764441078, 3309.7848639838576, 3387.627360990289, 983.961920174216, 1005.8440941654055, 1012.6405126180174, 1064.4571268652965, 1084.7179733269327, 15352.07887526752, 15360.385584576716, 15428.0, 15478.767818482731, 15524.223788810514, 4624.699394539344, 4835.117500501718, 4879.56083952446, 4960.0327936052845, 4965.528274813887, 10885.945570272257, 10890.727731806768, 10970.561177552809, 10975.121990240921, 10976.12191024716, 5688.943110568841, 5722.399148089474, 5726.169705392778, 5737.168110623936, 5738.971305143447, 5138.691678499302, 5284.7803922352705, 5313.229581710631, 5324.334458192726, 5383.461653834585, 3641.708663306929, 3754.2679177560112, 3803.1823158021157, 3825.1502630540426, 3855.903602409906, 1061.2783307351076, 1066.941318227505, 1068.503146037081, 1082.3289560472558, 1084.5065495199665, 666.7866282789557, 684.555039224498, 690.3234829866759, 696.7422053840011, 707.8478127202676, 5121.257417674491, 5166.095933211673, 5254.5533629641905, 5417.972910135503, 5455.236266922634, 537.3095572189717, 543.3968295192333, 554.6450271826035, 554.7115499940089, 555.0536335547881, 3202.6637203093806, 3223.854926528312, 3356.594730176065, 3582.946255806165, 3630.674803696632, 12067.155299129152, 12886.0, 12894.48422063107, 12898.871011289955, 12938.288394138224, 12694.80957785634, 12891.0, 13538.187708737507, 13797.172169669851, 13810.10234334765, 7762.340201082971, 7792.103908050533, 7805.765827025199, 7900.644470998819, 7913.208679132156, 5500.312460942382, 5515.365732940602, 5564.165375193753, 5587.0502014656795, 5691.943080569141, 11579.247348922294, 11914.702132446411, 11953.282803031845, 12155.574554890536, 12172.0, 12420.0, 12427.0, 12506.499740010298, 12532.498700051896, 12679.302638354979, 7510.211427800003, 7614.238576142341, 8036.919630803617, 8389.370797190113, 8401.369897257608, 9868.901310987085, 9946.104850563484, 9985.0, 10007.649732259337, 10043.89956100459, 8138.430309878252, 8313.792155196168, 8454.196851299117, 8576.785580360542, 8642.178992995656, 8020.799480013046, 8054.275115239657, 8163.428560000743, 8189.795255118432, 8238.794030149294, 7013.193482749549, 7138.571685698875, 7139.785806425815, 7143.214246432992, 7158.0, 4889.315495830516, 5037.874053148701, 5051.393832740095, 5095.566876815512, 5318.441563635763, 4985.675931064469, 5086.440491545853, 5125.8718532037, 5173.715445650525, 5183.248428977852], "value": 4654.671782257319, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.03159406414545, 356.20566137513345, 364.2587334773736, 365.51934206518433, 372.1997704934391, 5472.26124473196, 5511.641743286684, 5558.499735023847, 5567.638103523268, 5622.718864056791, 5381.838544843661, 5513.641613295143, 5514.558835293177, 5516.779328826842, 5539.362973258077, 4175.248455278049, 4289.978550107245, 4299.742015479065, 4305.634021108194, 4326.480822301328, 4289.1636130954475, 4292.570742925698, 4297.333913243452, 4310.719803212797, 4324.091940692459, 4270.081932384553, 4283.971846756772, 4285.742855428684, 4285.892852678677, 4295.914081718363, 4160.6061969240345, 4274.3543735662, 4288.935665965013, 4327.632151267146, 4346.1090476452255, 3863.4011728181895, 3882.63115004077, 3886.6113388661192, 3890.8832735017713, 3911.3155197840265, 5411.594130440233, 5420.105682562373, 5427.565794736451, 5437.673739575638, 5451.918221226685, 4980.526849949249, 5145.536901678867, 5178.300929374562, 5180.248863914749, 5196.2465442511, 5909.320428150775, 5924.881502369928, 5937.426581955785, 5950.018246989242, 5957.6127551709, 4407.471103467572, 4418.977905110454, 4429.6899217054815, 4445.222086134913, 4450.5104438511735, 6139.508839292846, 6262.060690896356, 6292.696334424464, 6305.117283580303, 6344.841378965562, 4461.330800379969, 4485.730856148642, 4495.865124046284, 4496.752678602708, 4515.029268707243, 4503.617192538605, 4571.817127314936, 4573.679842410999, 4586.908261834811, 4593.724376537419, 5085.415177254663, 5089.541941225308, 5098.770555324945, 5120.1039818031695, 5129.410117836422, 5915.911261331084, 5946.345901950782, 5947.9702601486715, 5949.196858424058, 5958.136070269873, 1545.3586761493855, 1593.219322531951, 1599.6880608281274, 1621.1488968291505, 1624.4801663467813, 1082.5453309609982, 1113.7549739057395, 1115.760111576015, 1124.859392575928, 1143.7369405036889, 5013.037093277701, 5076.923846142311, 5078.390593128848, 5081.161608334583, 5104.106781313255, 6053.364396738367, 6060.696965151725, 6078.422549857756, 6094.695265236721, 6098.69506524672, 4923.759689341341, 4971.850844474671, 5093.363329583802, 5106.4382917879, 5143.819966301162, 3194.329190869897, 3204.5193221017034, 3231.321422501254, 3236.7086962173516, 3245.8863939761995, 5443.972780136153, 5616.410276920946, 5620.91568626471, 5630.71846407678, 5642.125470551989, 6001.259634705973, 6212.415833962311, 6261.655608941552, 6273.37266273369, 6292.8426789329715, 5611.354694210137, 5619.241402410704, 5625.437456254342, 5638.041532939328, 5658.462446067617, 6019.72911219005, 6102.664353460602, 6106.511479081574, 6123.418275263843, 6124.703236286393, 6002.669853158118, 6012.488938440107, 6049.062395328731, 6056.45491905713, 6081.361457047124, 5665.0, 5667.433256674464, 5674.0, 5675.68783716883, 5689.317281926195, 4005.4792876925812, 4009.1179940413062, 4011.1777085696776, 4037.9596204037584, 4051.3207245631343, 6124.54065945047, 6150.35421280777, 6164.321924588202, 6169.84575385619, 6180.6291622502795, 5864.472197502075, 5893.852653683693, 5925.4370834770625, 5934.7922822701, 5935.465808077293, 5725.513331366714, 5854.619449735754, 5880.529867533117, 5932.822015339547, 5942.0, 5811.82564523065, 5812.476877081083, 5820.330661973758, 5828.76684932598, 5836.474717275466, 5789.1605717171615, 5897.970510147422, 5934.050551911673, 5942.524598032233, 5964.4492431968865, 5735.541156707537, 5741.100744124191, 5758.531574448489, 5762.049261871744, 5767.942320576741], "value": 4470.1132600357805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.9781006569805, 750.8122969257682, 751.4589495563195, 756.4137793210261, 766.9616519174042, 10684.732881677963, 11357.034652054565, 12556.748865022693, 13522.188668679873, 13572.253526056074, 13895.652608684788, 14093.154410735337, 14663.486777962773, 14675.633109172277, 14743.26283685814, 858.78530367408, 880.995595022024, 883.6642076011107, 884.5577211394303, 886.6630680341461, 895.1138373010705, 900.1628485508475, 903.8373092843285, 904.2494729374636, 905.1265528764741, 928.8049509602957, 938.3431597881477, 939.3002213351028, 941.2470023980823, 945.1304799584365, 925.8148370325928, 927.9814403711922, 932.7901222225013, 940.962361505539, 941.9670311539097, 686.9038334633156, 690.7858563845224, 692.6882902693758, 693.639307560066, 695.2526034512869, 12606.810897836449, 12829.807552886714, 13024.218546887218, 13687.657808554766, 13784.724305513833, 14546.418143274257, 14583.0, 14652.633684157874, 14766.630834229123, 14969.326380312912, 12333.321667308295, 12519.12366134371, 12521.56174533896, 12582.119251652388, 12706.428210730539, 2925.3417980954328, 2956.1870485616414, 2959.2453924249394, 2970.1386597886585, 2971.6582593001867, 58897.41102588962, 59370.10944835831, 60632.0, 61146.08280875791, 63107.0, 12370.257784532956, 12618.873811261954, 12711.745765084646, 12748.745025099446, 12758.617241482585, 18482.445526634223, 18920.33778817735, 18951.241950321833, 18956.409834348415, 18967.43097707071, 5787.623804452697, 6018.488428483628, 6025.548083893726, 6035.698215089228, 6178.505719542426, 2751.5735061065566, 2835.036087730182, 2849.9857500712365, 2853.657561092682, 2866.154484427099, 3081.245094951751, 3158.1788734928623, 3168.588083549124, 3190.888318908827, 3784.3377408953875, 731.3417923868561, 747.200495469853, 748.7379417203935, 750.4521699159644, 751.2412463411994, 563.4056070845215, 570.4438172781505, 578.4764787866987, 578.9478946894716, 598.2850493660121, 9746.75633109178, 9925.2059835213, 10697.83953240702, 11016.889831101586, 11178.664640060648, 598.7724664627501, 606.121124369657, 610.9786157484556, 618.6226401894841, 624.2820756130395, 4364.170807546556, 4526.140033393711, 4530.932036019462, 4549.977250113729, 4569.109023740339, 59790.0, 60974.39025609687, 62241.377586223556, 63877.36122638714, 64237.0, 54785.1782223267, 55238.0, 55332.72333638306, 56884.43115568791, 58087.0, 49659.503404965486, 49802.25296620554, 49972.50027499751, 50315.24527132096, 51296.99999999925, 9461.905380946102, 9500.144986951207, 9567.521623918637, 9643.180329671775, 9878.654247101316, 26442.07452739222, 27272.181834544994, 27333.72666273312, 27392.0, 27521.449571008066, 31244.0, 32297.51553726743, 32298.515522266716, 32566.83716581402, 33430.0, 12082.75834483323, 12149.75700486003, 12304.446299916704, 12498.312592807482, 12499.500019999097, 12736.299503527394, 12893.871061289266, 12973.805392918925, 13091.738165236451, 13309.800352994907, 11536.480858361561, 11893.405329733305, 11906.642800715992, 11977.64067077989, 12009.579664711693, 13062.804057938949, 13298.268595227355, 13554.390052447467, 13730.0, 13973.0, 14172.574822755334, 15484.380624774883, 15903.443379481663, 16229.59426014359, 16415.0, 9539.189168920442, 9959.751006224902, 10821.621243256763, 10836.566537338418, 11180.776384472427, 10992.17558683086, 11398.658040258806, 11488.597899073493, 11553.711157221136, 11563.537458501565], "value": 6607.814403564961, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 111.0, 112.0, 111.0, 111.0, 113.0, 111.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 125.0, 184.0, 125.0, 125.0, 124.0, 125.0, 147.0, 124.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 164.0, 167.0, 169.0, 169.0, 166.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 100.0, 75.0, 75.0, 75.0, 75.0, 106.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 105.0, 84.0, 83.0, 83.0, 98.0, 83.0, 83.0, 104.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 152.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 58.0, 56.0, 65.0, 55.0, 58.0, 55.0, 55.0, 56.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 55.0, 55.0, 58.0, 55.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 82.0, 83.0, 83.0, 88.0, 82.0, 82.0, 89.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 133.0, 132.0, 132.0, 134.0, 139.0, 142.0, 133.0, 183.0, 131.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 196.0, 191.0, 201.0, 196.0, 194.0, 185.0, 192.0, 193.0], "value": 194.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 82.0, 74.0, 81.0, 74.0, 73.0, 72.0, 80.0, 73.0], "value": 76.0, "unit": "score"}]}]} 09:05:32 INFO - Return code: 0 09:05:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:32 INFO - # TBPL SUCCESS # 09:05:32 INFO - Running post-action listener: _resource_record_post_action 09:05:32 INFO - [mozharness: 2017-05-17 16:05:32.892143Z] Finished run-tests step (success) 09:05:32 INFO - Running post-run listener: _resource_record_post_run 09:05:32 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 374149120; Read time: 252; Write time: 199968 09:05:32 INFO - TinderboxPrint: CPU usage
13.3% 09:05:32 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 252 09:05:32 INFO - TinderboxPrint: I/O write bytes / time
374,149,120 / 199,968 09:05:32 INFO - TinderboxPrint: CPU idle
8,290.7 (86.7%) 09:05:32 INFO - TinderboxPrint: CPU user
1,214.2 (12.7%) 09:05:32 INFO - TinderboxPrint: Swap in / out
0 / 0 09:05:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106307584; Read time: 72; Write time: 81760 09:05:32 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 267268096; Read time: 172; Write time: 118176 09:05:33 INFO - Running post-run listener: _upload_blobber_files 09:05:33 INFO - Blob upload gear active. 09:05:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:33 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:05:33 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:05:33 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:05:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:36 INFO - (blobuploader) - INFO - Done attempting. 09:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:05:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:37 INFO - (blobuploader) - INFO - Done attempting. 09:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:38 INFO - (blobuploader) - INFO - Done attempting. 09:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:39 INFO - (blobuploader) - INFO - Done attempting. 09:05:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:39 INFO - Return code: 0 09:05:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33d51c598c3dc167fa8ed280a2b885915eaa098858f4a904cdec80fc9897acf01da7655b592753e1c842be900ff75b7ea132a3025896dbe68e533a218f2e948", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66345d60c337482fe752ee843e0f69f448589ca58955a0ca61653c04d8cbecbbedc585d440fd85719a489d96411c54fd2d792abe3b2de005b22b15b47b7c3e6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/739c5aa6fedc8c8a6a1efa7042f4361ffc35cb99ebd605ee3b134cbaf0f1a4f6fc8447d5d8105e1704f834a5b402e5fb1b2c1db5b927f420af67497142b49058", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc92c230d90dd9eff7714e0d0e0101c6873d26f0a63f8f36a5b8fecbe5e312c56e653e74a7e7ba0e2f109c24ba963b161876f3862a12f41f1c49970499826d5a"} 09:05:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:39 INFO - Contents: 09:05:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33d51c598c3dc167fa8ed280a2b885915eaa098858f4a904cdec80fc9897acf01da7655b592753e1c842be900ff75b7ea132a3025896dbe68e533a218f2e948", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66345d60c337482fe752ee843e0f69f448589ca58955a0ca61653c04d8cbecbbedc585d440fd85719a489d96411c54fd2d792abe3b2de005b22b15b47b7c3e6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/739c5aa6fedc8c8a6a1efa7042f4361ffc35cb99ebd605ee3b134cbaf0f1a4f6fc8447d5d8105e1704f834a5b402e5fb1b2c1db5b927f420af67497142b49058", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc92c230d90dd9eff7714e0d0e0101c6873d26f0a63f8f36a5b8fecbe5e312c56e653e74a7e7ba0e2f109c24ba963b161876f3862a12f41f1c49970499826d5a"} 09:05:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:39 INFO - Copying logs to upload dir... 09:05:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.231021 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-05-17 09:05:39.860584) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 09:05:39.865383) ========= 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=232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801 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/e33d51c598c3dc167fa8ed280a2b885915eaa098858f4a904cdec80fc9897acf01da7655b592753e1c842be900ff75b7ea132a3025896dbe68e533a218f2e948", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66345d60c337482fe752ee843e0f69f448589ca58955a0ca61653c04d8cbecbbedc585d440fd85719a489d96411c54fd2d792abe3b2de005b22b15b47b7c3e6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/739c5aa6fedc8c8a6a1efa7042f4361ffc35cb99ebd605ee3b134cbaf0f1a4f6fc8447d5d8105e1704f834a5b402e5fb1b2c1db5b927f420af67497142b49058", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc92c230d90dd9eff7714e0d0e0101c6873d26f0a63f8f36a5b8fecbe5e312c56e653e74a7e7ba0e2f109c24ba963b161876f3862a12f41f1c49970499826d5a"} build_url:https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011064 build_url: 'https://queue.taskcluster.net/v1/task/Ma6pZGD0TPKKur90mE0p3A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33d51c598c3dc167fa8ed280a2b885915eaa098858f4a904cdec80fc9897acf01da7655b592753e1c842be900ff75b7ea132a3025896dbe68e533a218f2e948", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66345d60c337482fe752ee843e0f69f448589ca58955a0ca61653c04d8cbecbbedc585d440fd85719a489d96411c54fd2d792abe3b2de005b22b15b47b7c3e6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/739c5aa6fedc8c8a6a1efa7042f4361ffc35cb99ebd605ee3b134cbaf0f1a4f6fc8447d5d8105e1704f834a5b402e5fb1b2c1db5b927f420af67497142b49058", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc92c230d90dd9eff7714e0d0e0101c6873d26f0a63f8f36a5b8fecbe5e312c56e653e74a7e7ba0e2f109c24ba963b161876f3862a12f41f1c49970499826d5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 09:05:39.892538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 09:05:39.892946) ========= 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=232498196343f89f466a4a9a000001c8-1495035075.749808-2023788801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 09:05:39.973680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 09:05:39.977006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 09:05:39.977307) ========= ========= Total master_lag: 0.30 =========