builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1495746535.81 results: success (0) revision: 55e5723b1e62190a38c00927eda796e2ad14778f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:55.811316) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:55.811803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:55.812077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:55.852237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:55.852549) ========= 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=9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 14:08:55-- 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% 31.5M=0s 2017-05-25 14:08:56 (31.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.185874 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:56.071162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:56.071488) ========= 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=9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017290 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:56.126416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:56.126758) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 55e5723b1e62190a38c00927eda796e2ad14778f --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 55e5723b1e62190a38c00927eda796e2ad14778f --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=9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 14:08:56,206 truncating revision to first 12 chars 2017-05-25 14:08:56,206 Setting DEBUG logging. 2017-05-25 14:08:56,206 attempt 1/10 2017-05-25 14:08:56,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/55e5723b1e62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 14:08:56,766 unpacking tar archive at: mozilla-central-55e5723b1e62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867163 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:57.006891) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:57.007208) ========= script_repo_revision: 55e5723b1e62190a38c00927eda796e2ad14778f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:57.007585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:57.007846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 14:08:57.015094) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-25 14:08:57.015372) ========= /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=9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:08:57 INFO - MultiFileLogger online at 20170525 14:08:57 in /builds/slave/test 14:08:57 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 14:08:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:57 INFO - {'append_to_log': False, 14:08:57 INFO - 'base_work_dir': '/builds/slave/test', 14:08:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:08:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:57 INFO - 'branch': 'Firefox-Non-PGO', 14:08:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:57 INFO - 'config_files': ('talos/linux_config.py',), 14:08:57 INFO - 'default_actions': ('clobber', 14:08:57 INFO - 'read-buildbot-config', 14:08:57 INFO - 'download-and-extract', 14:08:57 INFO - 'populate-webroot', 14:08:57 INFO - 'create-virtualenv', 14:08:57 INFO - 'install', 14:08:57 INFO - 'run-tests'), 14:08:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:57 INFO - 'download_minidump_stackwalk': True, 14:08:57 INFO - 'download_symbols': 'ondemand', 14:08:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:57 INFO - 'gecko_profile': False, 14:08:57 INFO - 'gecko_profile_interval': 0, 14:08:57 INFO - 'installer_path': 'installer.exe', 14:08:57 INFO - 'log_level': 'info', 14:08:57 INFO - 'log_name': 'talos', 14:08:57 INFO - 'log_to_console': True, 14:08:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:08:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:08:57 INFO - 'opt_config_files': (), 14:08:57 INFO - 'pip_index': False, 14:08:57 INFO - 'suite': 'dromaeojs-e10s', 14:08:57 INFO - 'system_bits': '32', 14:08:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:57 INFO - 'title': 'talos-linux64-ix-088', 14:08:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:57 INFO - 'use_talos_json': True, 14:08:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:57 INFO - 'work_dir': 'build'} 14:08:57 INFO - [mozharness: 2017-05-25 21:08:57.310232Z] Running clobber step. 14:08:57 INFO - Running pre-action listener: _resource_record_pre_action 14:08:57 INFO - Running main action method: clobber 14:08:57 INFO - rmtree: /builds/slave/test/build 14:08:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:58 INFO - Running post-action listener: _resource_record_post_action 14:08:58 INFO - [mozharness: 2017-05-25 21:08:58.296985Z] Finished clobber step (success) 14:08:58 INFO - [mozharness: 2017-05-25 21:08:58.297086Z] Running read-buildbot-config step. 14:08:58 INFO - Running pre-action listener: _resource_record_pre_action 14:08:58 INFO - Running main action method: read_buildbot_config 14:08:58 INFO - Using buildbot properties: 14:08:58 INFO - { 14:08:58 INFO - "project": "", 14:08:58 INFO - "product": "firefox", 14:08:58 INFO - "who": "ryanvm@gmail.com", 14:08:58 INFO - "installer_path": "public/build/target.tar.bz2", 14:08:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:08:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:08:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:08:58 INFO - "stage_platform": "linux64", 14:08:58 INFO - "basedir": "/builds/slave/test", 14:08:58 INFO - "buildnumber": 903, 14:08:58 INFO - "platform": "ubuntu64_hw", 14:08:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:08:58 INFO - "slavebuilddir": "test", 14:08:58 INFO - "taskId": "a4Jsc4nQRg66EEp2iXMuWg", 14:08:58 INFO - "branch": "mozilla-central", 14:08:58 INFO - "script_repo_revision": "production", 14:08:58 INFO - "revision": "55e5723b1e62190a38c00927eda796e2ad14778f", 14:08:58 INFO - "slavename": "talos-linux64-ix-088", 14:08:58 INFO - "repo_path": "mozilla-central" 14:08:58 INFO - } 14:08:58 INFO - Finding installer, test and symbols from parent task. 14:08:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a4Jsc4nQRg66EEp2iXMuWg'}, attempt #1 14:08:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a4Jsc4nQRg66EEp2iXMuWg'}, attempt #1 14:08:59 INFO - Task dependencies: P-dSwiUwRgaQiB0H54wtog 14:08:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog'}, attempt #1 14:09:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2 14:09:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/test_packages.json 14:09:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.crashreporter-symbols.zip 14:09:00 INFO - Running post-action listener: _resource_record_post_action 14:09:00 INFO - [mozharness: 2017-05-25 21:09:00.362538Z] Finished read-buildbot-config step (success) 14:09:00 INFO - [mozharness: 2017-05-25 21:09:00.362764Z] Running download-and-extract step. 14:09:00 INFO - Running pre-action listener: _resource_record_pre_action 14:09:00 INFO - Running main action method: download_and_extract 14:09:00 INFO - mkdir: /builds/slave/test/build/tests 14:09:00 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')]} 14:09:00 INFO - trying https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.test_packages.json 14:09:00 INFO - Downloading https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:09:00 INFO - Downloaded 986 bytes. 14:09:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:09:00 INFO - Using the following test package requirements: 14:09:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:09:00 INFO - u'common': [u'target.common.tests.zip'], 14:09:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:09:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:09:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:09:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:09:00 INFO - u'mozbase': [u'target.common.tests.zip'], 14:09:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:09:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:09:00 INFO - u'web-platform': [u'target.common.tests.zip', 14:09:00 INFO - u'target.web-platform.tests.zip'], 14:09:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:09:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:09:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.common.tests.zip 14:09:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:09:00 INFO - Fetch https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.common.tests.zip into memory 14:09:02 INFO - Content-Length response header: 63525233 14:09:02 INFO - Bytes received: 63525233 14:09:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:09:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.common.tests.zip 14:09:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:09:12 INFO - Fetch https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.common.tests.zip into memory 14:09:13 INFO - Content-Length response header: 63525233 14:09:13 INFO - Bytes received: 63525233 14:09:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.talos.tests.zip 14:09:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:09:26 INFO - Fetch https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.talos.tests.zip into memory 14:09:27 INFO - Content-Length response header: 14411888 14:09:27 INFO - Bytes received: 14411888 14:09: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')]} 14:09:27 INFO - trying https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2 14:09:27 INFO - Downloading https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:09:28 INFO - Downloaded 54015076 bytes. 14:09:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2 14:09:28 INFO - mkdir: /builds/slave/test/properties 14:09:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:28 INFO - Contents: 14:09:28 INFO - build_url:https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2 14:09:28 INFO - Running post-action listener: _resource_record_post_action 14:09:28 INFO - Running post-action listener: set_extra_try_arguments 14:09:28 INFO - [mozharness: 2017-05-25 21:09:28.404255Z] Finished download-and-extract step (success) 14:09:28 INFO - [mozharness: 2017-05-25 21:09:28.404354Z] Running populate-webroot step. 14:09:28 INFO - Running pre-action listener: _resource_record_pre_action 14:09:28 INFO - Running main action method: populate_webroot 14:09:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:28 INFO - '--tppagecycles', 14:09:28 INFO - '7'], 14:09:28 INFO - 'tests': ['tsvgm']}}, 14:09:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['damp', 'tps']}, 14:09:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'tests': ['damp', 'tps']}, 14:09:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['dromaeo_dom']}, 14:09:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:09:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:09:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:09:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['a11yr', 14:09:28 INFO - 'ts_paint', 14:09:28 INFO - 'tpaint', 14:09:28 INFO - 'sessionrestore', 14:09:28 INFO - 'sessionrestore_no_auto_restore', 14:09:28 INFO - 'tabpaint']}, 14:09:28 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:28 INFO - 'ts_paint', 14:09:28 INFO - 'tpaint', 14:09:28 INFO - 'sessionrestore', 14:09:28 INFO - 'sessionrestore_no_auto_restore', 14:09:28 INFO - 'tabpaint']}, 14:09:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:28 INFO - 'ts_paint', 14:09:28 INFO - 'tpaint', 14:09:28 INFO - 'sessionrestore', 14:09:28 INFO - 'sessionrestore_no_auto_restore', 14:09:28 INFO - 'tabpaint']}, 14:09:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:28 INFO - 'ts_paint', 14:09:28 INFO - 'tpaint', 14:09:28 INFO - 'sessionrestore', 14:09:28 INFO - 'sessionrestore_no_auto_restore', 14:09:28 INFO - 'tabpaint']}, 14:09:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['a11yr', 14:09:28 INFO - 'ts_paint', 14:09:28 INFO - 'tpaint', 14:09:28 INFO - 'sessionrestore', 14:09:28 INFO - 'sessionrestore_no_auto_restore', 14:09:28 INFO - 'tabpaint']}, 14:09:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['a11yr', 14:09:28 INFO - 'ts_paint', 14:09:28 INFO - 'tpaint', 14:09:28 INFO - 'sessionrestore', 14:09:28 INFO - 'sessionrestore_no_auto_restore', 14:09:28 INFO - 'tabpaint']}, 14:09:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:09:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:09:28 INFO - 'bloom_basic_ref']}, 14:09:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['tsvgx', 14:09:28 INFO - 'tsvgr_opacity', 14:09:28 INFO - 'tart', 14:09:28 INFO - 'tscrollx', 14:09:28 INFO - 'cart', 14:09:28 INFO - 'tsvg_static']}, 14:09:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:28 INFO - 'tsvgr_opacity', 14:09:28 INFO - 'tart', 14:09:28 INFO - 'tscrollx', 14:09:28 INFO - 'cart', 14:09:28 INFO - 'tsvg_static']}, 14:09:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'talos_options': ['--disable-e10s'], 14:09:28 INFO - 'tests': ['tp5o']}, 14:09:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:09:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'talos_options': ['--disable-e10s', 14:09:28 INFO - '--xperf_path', 14:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:28 INFO - 'tests': ['tp5n']}, 14:09:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:09:28 INFO - 'talos_options': ['--xperf_path', 14:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:28 INFO - 'tests': ['tp5n']}}, 14:09:28 INFO - 'talos.zip': {'path': '', 14:09:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:28 INFO - Running post-action listener: _resource_record_post_action 14:09:28 INFO - [mozharness: 2017-05-25 21:09:28.418468Z] Finished populate-webroot step (success) 14:09:28 INFO - [mozharness: 2017-05-25 21:09:28.418558Z] Running create-virtualenv step. 14:09:28 INFO - Running pre-action listener: _resource_record_pre_action 14:09:28 INFO - Running main action method: create_virtualenv 14:09:28 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:28 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 14:09:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:28 INFO - Using real prefix '/usr' 14:09:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:29 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:31 INFO - Installing pip.................done. 14:09:31 INFO - Return code: 0 14:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:09:31 INFO - Reading from file tmpfile_stdout 14:09:31 INFO - Output received: 14:09:31 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) 14:09:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09:31 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')]} 14:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:31 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')]} 14:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:31 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:31 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 14:09:31 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 14:09:31 INFO - Using env: {'DISPLAY': ':0', 14:09:31 INFO - 'HOME': '/home/cltbld', 14:09:31 INFO - 'LANG': 'en_US.UTF-8', 14:09:31 INFO - 'LANGUAGE': 'en_US:en', 14:09:31 INFO - 'LOGNAME': 'cltbld', 14:09:31 INFO - 'MAIL': '/var/mail/cltbld', 14:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:31 INFO - 'MOZ_NO_REMOTE': '1', 14:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:31 INFO - 'NO_EM_RESTART': '1', 14:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:31 INFO - 'PWD': '/builds/slave/test', 14:09:31 INFO - 'SHELL': '/bin/bash', 14:09:31 INFO - 'SHLVL': '1', 14:09:31 INFO - 'TERM': 'linux', 14:09:31 INFO - 'TMOUT': '86400', 14:09:31 INFO - 'USER': 'cltbld', 14:09:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:31 INFO - '_': '/tools/buildbot/bin/python'} 14:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:31 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 14:09:31 INFO - Cleaning up... 14:09:31 INFO - Return code: 0 14:09:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09:31 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')]} 14:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:31 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')]} 14:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:31 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:31 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 14:09:31 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 14:09:31 INFO - Using env: {'DISPLAY': ':0', 14:09:31 INFO - 'HOME': '/home/cltbld', 14:09:31 INFO - 'LANG': 'en_US.UTF-8', 14:09:31 INFO - 'LANGUAGE': 'en_US:en', 14:09:31 INFO - 'LOGNAME': 'cltbld', 14:09:31 INFO - 'MAIL': '/var/mail/cltbld', 14:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:31 INFO - 'MOZ_NO_REMOTE': '1', 14:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:31 INFO - 'NO_EM_RESTART': '1', 14:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:31 INFO - 'PWD': '/builds/slave/test', 14:09:31 INFO - 'SHELL': '/bin/bash', 14:09:31 INFO - 'SHLVL': '1', 14:09:31 INFO - 'TERM': 'linux', 14:09:31 INFO - 'TMOUT': '86400', 14:09:31 INFO - 'USER': 'cltbld', 14:09:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:31 INFO - '_': '/tools/buildbot/bin/python'} 14:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:31 INFO - Downloading/unpacking psutil>=3.1.1 14:09: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 14:09: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 14:09: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 14:09: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 14:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:33 INFO - Installing collected packages: psutil 14:09:33 INFO - Running setup.py install for psutil 14:09:33 INFO - building 'psutil._psutil_linux' extension 14:09:33 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 14:09:34 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 14:09:34 INFO - building 'psutil._psutil_posix' extension 14:09:34 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 14:09:34 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 14:09:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:34 INFO - Successfully installed psutil 14:09:34 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:09:34 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')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 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')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'DISPLAY': ':0', 14:09:34 INFO - 'HOME': '/home/cltbld', 14:09:34 INFO - 'LANG': 'en_US.UTF-8', 14:09:34 INFO - 'LANGUAGE': 'en_US:en', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MAIL': '/var/mail/cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SHLVL': '1', 14:09:34 INFO - 'TERM': 'linux', 14:09:34 INFO - 'TMOUT': '86400', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - '_': '/tools/buildbot/bin/python'} 14:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:09:35 INFO - Installing collected packages: mozsystemmonitor 14:09:35 INFO - Running setup.py install for mozsystemmonitor 14:09:35 INFO - Successfully installed mozsystemmonitor 14:09:35 INFO - Cleaning up... 14:09:35 INFO - Return code: 0 14:09:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:09:35 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')]} 14:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:35 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')]} 14:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:35 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 14:09:35 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 14:09:35 INFO - Using env: {'DISPLAY': ':0', 14:09:35 INFO - 'HOME': '/home/cltbld', 14:09:35 INFO - 'LANG': 'en_US.UTF-8', 14:09:35 INFO - 'LANGUAGE': 'en_US:en', 14:09:35 INFO - 'LOGNAME': 'cltbld', 14:09:35 INFO - 'MAIL': '/var/mail/cltbld', 14:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:35 INFO - 'MOZ_NO_REMOTE': '1', 14:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:35 INFO - 'NO_EM_RESTART': '1', 14:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:35 INFO - 'PWD': '/builds/slave/test', 14:09:35 INFO - 'SHELL': '/bin/bash', 14:09:35 INFO - 'SHLVL': '1', 14:09:35 INFO - 'TERM': 'linux', 14:09:35 INFO - 'TMOUT': '86400', 14:09:35 INFO - 'USER': 'cltbld', 14:09:35 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:35 INFO - '_': '/tools/buildbot/bin/python'} 14:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:36 INFO - Downloading/unpacking jsonschema==2.5.1 14:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:37 INFO - warning: no files found matching '*.txt' 14:09:37 INFO - no previously-included directories found matching 'build' 14:09:37 INFO - no previously-included directories found matching 'dist' 14:09:37 INFO - no previously-included directories found matching '.git*' 14:09:37 INFO - Installing collected packages: jsonschema, functools32 14:09:37 INFO - Running setup.py install for functools32 14:09:37 INFO - warning: no files found matching '*.txt' 14:09:37 INFO - no previously-included directories found matching 'build' 14:09:37 INFO - no previously-included directories found matching 'dist' 14:09:37 INFO - no previously-included directories found matching '.git*' 14:09:37 INFO - Successfully installed jsonschema functools32 14:09:37 INFO - Cleaning up... 14:09:37 INFO - Return code: 0 14:09:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:09:37 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')]} 14:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:37 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')]} 14:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:37 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:37 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 14:09:37 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 14:09:37 INFO - Using env: {'DISPLAY': ':0', 14:09:37 INFO - 'HOME': '/home/cltbld', 14:09:37 INFO - 'LANG': 'en_US.UTF-8', 14:09:37 INFO - 'LANGUAGE': 'en_US:en', 14:09:37 INFO - 'LOGNAME': 'cltbld', 14:09:37 INFO - 'MAIL': '/var/mail/cltbld', 14:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:37 INFO - 'MOZ_NO_REMOTE': '1', 14:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:37 INFO - 'NO_EM_RESTART': '1', 14:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:37 INFO - 'PWD': '/builds/slave/test', 14:09:37 INFO - 'SHELL': '/bin/bash', 14:09:37 INFO - 'SHLVL': '1', 14:09:37 INFO - 'TERM': 'linux', 14:09:37 INFO - 'TMOUT': '86400', 14:09:37 INFO - 'USER': 'cltbld', 14:09:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:37 INFO - '_': '/tools/buildbot/bin/python'} 14:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:09:37 INFO - Cleaning up... 14:09:37 INFO - Return code: 0 14:09:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:37 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')]} 14:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:37 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')]} 14:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:37 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:37 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 14:09:37 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 14:09:37 INFO - Using env: {'DISPLAY': ':0', 14:09:37 INFO - 'HOME': '/home/cltbld', 14:09:37 INFO - 'LANG': 'en_US.UTF-8', 14:09:37 INFO - 'LANGUAGE': 'en_US:en', 14:09:37 INFO - 'LOGNAME': 'cltbld', 14:09:37 INFO - 'MAIL': '/var/mail/cltbld', 14:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:37 INFO - 'MOZ_NO_REMOTE': '1', 14:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:37 INFO - 'NO_EM_RESTART': '1', 14:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:37 INFO - 'PWD': '/builds/slave/test', 14:09:37 INFO - 'SHELL': '/bin/bash', 14:09:37 INFO - 'SHLVL': '1', 14:09:37 INFO - 'TERM': 'linux', 14:09:37 INFO - 'TMOUT': '86400', 14:09:37 INFO - 'USER': 'cltbld', 14:09:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:37 INFO - '_': '/tools/buildbot/bin/python'} 14:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:39 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:39 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 14:09:39 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 14:09:39 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 14:09:39 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 14:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:39 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 14:09:39 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 14:09:39 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 14:09:39 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 14:09:39 INFO - Downloading docopt-0.6.1.tar.gz 14:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:39 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:39 INFO - Running setup.py install for blobuploader 14:09:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:39 INFO - Running setup.py install for requests 14:09:40 INFO - Running setup.py install for docopt 14:09:40 INFO - Successfully installed blobuploader requests docopt 14:09:40 INFO - Cleaning up... 14:09:40 INFO - Return code: 0 14:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:40 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')]} 14:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:40 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')]} 14:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:40 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:40 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 14:09:40 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 14:09:40 INFO - Using env: {'DISPLAY': ':0', 14:09:40 INFO - 'HOME': '/home/cltbld', 14:09:40 INFO - 'LANG': 'en_US.UTF-8', 14:09:40 INFO - 'LANGUAGE': 'en_US:en', 14:09:40 INFO - 'LOGNAME': 'cltbld', 14:09:40 INFO - 'MAIL': '/var/mail/cltbld', 14:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:40 INFO - 'MOZ_NO_REMOTE': '1', 14:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:40 INFO - 'NO_EM_RESTART': '1', 14:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:40 INFO - 'PWD': '/builds/slave/test', 14:09:40 INFO - 'SHELL': '/bin/bash', 14:09:40 INFO - 'SHLVL': '1', 14:09:40 INFO - 'TERM': 'linux', 14:09:40 INFO - 'TMOUT': '86400', 14:09:40 INFO - 'USER': 'cltbld', 14:09:40 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:40 INFO - '_': '/tools/buildbot/bin/python'} 14:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:40 INFO - Running setup.py (path:/tmp/pip-QlI2sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:40 INFO - Running setup.py (path:/tmp/pip-Nwo53R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:40 INFO - Running setup.py (path:/tmp/pip-E6Fo38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:40 INFO - Running setup.py (path:/tmp/pip-0fvMMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:40 INFO - Running setup.py (path:/tmp/pip-pIKNm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:40 INFO - Running setup.py (path:/tmp/pip-_AMrRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:40 INFO - Running setup.py (path:/tmp/pip-c6xSbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:41 INFO - Running setup.py (path:/tmp/pip-U5jwW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:41 INFO - Running setup.py (path:/tmp/pip-8mOLxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:41 INFO - Running setup.py (path:/tmp/pip-7tFzhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:41 INFO - Running setup.py (path:/tmp/pip-mK9n5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:41 INFO - Running setup.py (path:/tmp/pip-yTmMVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:41 INFO - Running setup.py (path:/tmp/pip-Fbepna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:41 INFO - Running setup.py (path:/tmp/pip-xzkLG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:41 INFO - Running setup.py (path:/tmp/pip-8fsXsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:41 INFO - Running setup.py (path:/tmp/pip-SOz35m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:41 INFO - Running setup.py (path:/tmp/pip-NhSsmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:41 INFO - Running setup.py install for manifestparser 14:09:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:41 INFO - Running setup.py install for mozcrash 14:09:41 INFO - Running setup.py install for mozdebug 14:09:42 INFO - Running setup.py install for mozdevice 14:09:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozfile 14:09:42 INFO - Running setup.py install for mozhttpd 14:09:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozinfo 14:09:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozInstall 14:09:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozleak 14:09:42 INFO - Running setup.py install for mozlog 14:09:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for moznetwork 14:09:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozprocess 14:09:43 INFO - Running setup.py install for mozprofile 14:09:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Running setup.py install for mozrunner 14:09:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Running setup.py install for mozscreenshot 14:09:43 INFO - Running setup.py install for moztest 14:09:43 INFO - Running setup.py install for mozversion 14:09:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:43 INFO - Cleaning up... 14:09:43 INFO - Return code: 0 14:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:43 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:43 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 14:09:43 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 14:09:43 INFO - Using env: {'DISPLAY': ':0', 14:09:43 INFO - 'HOME': '/home/cltbld', 14:09:43 INFO - 'LANG': 'en_US.UTF-8', 14:09:43 INFO - 'LANGUAGE': 'en_US:en', 14:09:43 INFO - 'LOGNAME': 'cltbld', 14:09:43 INFO - 'MAIL': '/var/mail/cltbld', 14:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:43 INFO - 'MOZ_NO_REMOTE': '1', 14:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:43 INFO - 'NO_EM_RESTART': '1', 14:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:43 INFO - 'PWD': '/builds/slave/test', 14:09:43 INFO - 'SHELL': '/bin/bash', 14:09:43 INFO - 'SHLVL': '1', 14:09:43 INFO - 'TERM': 'linux', 14:09:43 INFO - 'TMOUT': '86400', 14:09:43 INFO - 'USER': 'cltbld', 14:09:43 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:43 INFO - '_': '/tools/buildbot/bin/python'} 14:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:43 INFO - Running setup.py (path:/tmp/pip-Mm2N0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:43 INFO - Running setup.py (path:/tmp/pip-fdHUb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:43 INFO - Running setup.py (path:/tmp/pip-vpnP39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:44 INFO - Running setup.py (path:/tmp/pip-4_lZhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:44 INFO - Running setup.py (path:/tmp/pip-RO_sy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:44 INFO - Running setup.py (path:/tmp/pip-nAeiYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:44 INFO - Running setup.py (path:/tmp/pip-bTQtch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:44 INFO - Running setup.py (path:/tmp/pip-OIGGeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:44 INFO - Running setup.py (path:/tmp/pip-5r7jIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:44 INFO - Running setup.py (path:/tmp/pip-gayK58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:44 INFO - Running setup.py (path:/tmp/pip-Lzsb7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:44 INFO - Running setup.py (path:/tmp/pip-EGNWMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:44 INFO - Running setup.py (path:/tmp/pip-VKTpn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:44 INFO - Running setup.py (path:/tmp/pip-YIHHEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:44 INFO - Running setup.py (path:/tmp/pip-vMECYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:44 INFO - Running setup.py (path:/tmp/pip-ESaGZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:44 INFO - Running setup.py (path:/tmp/pip-XBcXrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:45 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)) 14:09:45 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)) 14:09:45 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)) 14:09:45 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)) 14:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:45 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 14:09:45 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 14:09:45 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 14:09:45 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 14:09:46 INFO - Downloading blessings-1.6.tar.gz 14:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:46 INFO - Installing collected packages: blessings 14:09:46 INFO - Running setup.py install for blessings 14:09:46 INFO - Successfully installed blessings 14:09:46 INFO - Cleaning up... 14:09:46 INFO - Return code: 0 14:09:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:46 INFO - Reading from file tmpfile_stdout 14:09:46 INFO - Current package versions: 14:09:46 INFO - argparse == 1.2.1 14:09:46 INFO - blessings == 1.6 14:09:46 INFO - blobuploader == 1.2.4 14:09:46 INFO - docopt == 0.6.1 14:09:46 INFO - functools32 == 3.2.3-2 14:09:46 INFO - jsonschema == 2.5.1 14:09:46 INFO - manifestparser == 1.1 14:09:46 INFO - mozInstall == 1.12 14:09:46 INFO - mozcrash == 1.0 14:09:46 INFO - mozdebug == 0.1 14:09:46 INFO - mozdevice == 0.51 14:09:46 INFO - mozfile == 1.2 14:09:46 INFO - mozhttpd == 0.7 14:09:46 INFO - mozinfo == 0.9 14:09:46 INFO - mozleak == 0.1 14:09:46 INFO - mozlog == 3.4 14:09:46 INFO - moznetwork == 0.27 14:09:46 INFO - mozprocess == 0.25 14:09:46 INFO - mozprofile == 0.28 14:09:46 INFO - mozrunner == 6.13 14:09:46 INFO - mozscreenshot == 0.1 14:09:46 INFO - mozsystemmonitor == 0.3 14:09:46 INFO - moztest == 0.8 14:09:46 INFO - mozversion == 1.4 14:09:46 INFO - psutil == 3.1.1 14:09:46 INFO - requests == 1.2.3 14:09:46 INFO - wsgiref == 0.1.2 14:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:09:46 INFO - Using env: {'DISPLAY': ':0', 14:09:46 INFO - 'HOME': '/home/cltbld', 14:09:46 INFO - 'LANG': 'en_US.UTF-8', 14:09:46 INFO - 'LANGUAGE': 'en_US:en', 14:09:46 INFO - 'LOGNAME': 'cltbld', 14:09:46 INFO - 'MAIL': '/var/mail/cltbld', 14:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:46 INFO - 'MOZ_NO_REMOTE': '1', 14:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:46 INFO - 'NO_EM_RESTART': '1', 14:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:46 INFO - 'PWD': '/builds/slave/test', 14:09:46 INFO - 'SHELL': '/bin/bash', 14:09:46 INFO - 'SHLVL': '1', 14:09:46 INFO - 'TERM': 'linux', 14:09:46 INFO - 'TMOUT': '86400', 14:09:46 INFO - 'USER': 'cltbld', 14:09:46 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:46 INFO - '_': '/tools/buildbot/bin/python'} 14:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 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)) 14:09:46 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 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 14:09:47 INFO - Downloading marionette_driver-1.4.0.tar.gz 14:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 14:09:48 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)) 14:09:48 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)) 14:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:09:48 INFO - Installing collected packages: marionette-driver 14:09:48 INFO - Running setup.py install for marionette-driver 14:09:48 INFO - Successfully installed marionette-driver 14:09:48 INFO - Cleaning up... 14:09:48 INFO - Return code: 0 14:09:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:48 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')]} 14:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:48 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')]} 14:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:48 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 0x1cbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, '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': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', '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 14:09:48 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 14:09:48 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 14:09:48 INFO - Using env: {'DISPLAY': ':0', 14:09:48 INFO - 'HOME': '/home/cltbld', 14:09:48 INFO - 'LANG': 'en_US.UTF-8', 14:09:48 INFO - 'LANGUAGE': 'en_US:en', 14:09:48 INFO - 'LOGNAME': 'cltbld', 14:09:48 INFO - 'MAIL': '/var/mail/cltbld', 14:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:48 INFO - 'MOZ_NO_REMOTE': '1', 14:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:48 INFO - 'NO_EM_RESTART': '1', 14:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:48 INFO - 'PWD': '/builds/slave/test', 14:09:48 INFO - 'SHELL': '/bin/bash', 14:09:48 INFO - 'SHLVL': '1', 14:09:48 INFO - 'TERM': 'linux', 14:09:48 INFO - 'TMOUT': '86400', 14:09:48 INFO - 'USER': 'cltbld', 14:09:48 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:48 INFO - '_': '/tools/buildbot/bin/python'} 14:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:48 INFO - Cleaning up... 14:09:48 INFO - Return code: 0 14:09:48 INFO - Running post-action listener: _resource_record_post_action 14:09:48 INFO - Running post-action listener: _start_resource_monitoring 14:09:48 INFO - Starting resource monitoring. 14:09:48 INFO - [mozharness: 2017-05-25 21:09:48.461549Z] Finished create-virtualenv step (success) 14:09:48 INFO - [mozharness: 2017-05-25 21:09:48.462035Z] Running install step. 14:09:48 INFO - Running pre-action listener: _resource_record_pre_action 14:09:48 INFO - Running main action method: install 14:09:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:48 INFO - Reading from file tmpfile_stdout 14:09:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:48 INFO - Reading from file tmpfile_stdout 14:09:48 INFO - Output received: 14:09:48 INFO - Usage: mozinstall [options] installer 14:09:48 INFO - Options: 14:09:48 INFO - -h, --help show this help message and exit 14:09:48 INFO - -d DEST, --destination=DEST 14:09:48 INFO - Directory to install application into. [default: 14:09:48 INFO - "/builds/slave/test"] 14:09:48 INFO - --app=APP Application being installed. [default: firefox] 14:09:48 INFO - mkdir: /builds/slave/test/build/application 14:09:48 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'] 14:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:10:04 INFO - Reading from file tmpfile_stdout 14:10:04 INFO - Output received: 14:10:04 INFO - /builds/slave/test/build/application/firefox/firefox 14:10:04 INFO - Running post-action listener: _resource_record_post_action 14:10:04 INFO - [mozharness: 2017-05-25 21:10:04.274996Z] Finished install step (success) 14:10:04 INFO - [mozharness: 2017-05-25 21:10:04.275272Z] Running run-tests step. 14:10:04 INFO - Running pre-action listener: _resource_record_pre_action 14:10:04 INFO - Running main action method: run_tests 14:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:04 INFO - Python 2.7.3 14:10:04 INFO - Return code: 0 14:10:04 INFO - grabbing minidump binary from tooltool 14:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:04 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 0x202b7a0>, '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 0x202c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202cb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:04 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 14:10:04 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 14:10:04 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 14:10:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:04 INFO - Return code: 0 14:10:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:10:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:04 INFO - ENV: RUST_BACKTRACE is now 1 14:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:04 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/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 14:10:04 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/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 14:10:04 INFO - Using env: {'DISPLAY': ':0', 14:10:04 INFO - 'HOME': '/home/cltbld', 14:10:04 INFO - 'LANG': 'en_US.UTF-8', 14:10:04 INFO - 'LANGUAGE': 'en_US:en', 14:10:04 INFO - 'LOGNAME': 'cltbld', 14:10:04 INFO - 'MAIL': '/var/mail/cltbld', 14:10:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:04 INFO - 'MOZ_NO_REMOTE': '1', 14:10:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:04 INFO - 'NO_EM_RESTART': '1', 14:10:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:04 INFO - 'PWD': '/builds/slave/test', 14:10:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:04 INFO - 'RUST_BACKTRACE': '1', 14:10:04 INFO - 'SHELL': '/bin/bash', 14:10:04 INFO - 'SHLVL': '1', 14:10:04 INFO - 'TERM': 'linux', 14:10:04 INFO - 'TMOUT': '86400', 14:10:04 INFO - 'USER': 'cltbld', 14:10:04 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364', 14:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:04 INFO - '_': '/tools/buildbot/bin/python'} 14:10:04 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/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 14:10:04 INFO - mozversion application_buildid: 20170525203424 14:10:04 INFO - mozversion application_changeset: 55e5723b1e62190a38c00927eda796e2ad14778f 14:10:04 INFO - mozversion application_display_name: Nightly 14:10:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:04 INFO - mozversion application_name: Firefox 14:10:04 INFO - mozversion application_remotingname: firefox 14:10:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:10:04 INFO - mozversion application_vendor: Mozilla 14:10:04 INFO - mozversion application_version: 55.0a1 14:10:04 INFO - mozversion platform_buildid: 20170525203424 14:10:04 INFO - mozversion platform_changeset: 55e5723b1e62190a38c00927eda796e2ad14778f 14:10:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:10:04 INFO - mozversion platform_version: 55.0a1 14:10:04 INFO - using testdate: 1495746604 14:10:04 INFO - actual date: 1495746604 14:10:04 INFO - starting webserver on 'localhost:59480' 14:10:04 INFO - SUITE-START | Running 2 tests 14:10:04 INFO - TEST-START | dromaeo_css 14:10:04 INFO - operating with platform_type : linux_ 14:10:04 INFO - Initialising browser for dromaeo_css test... 14:10:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59480/getInfo.html -profile /tmp/tmpoc3_UI/profile 14:10:04 INFO - TEST-INFO | started process 3289 (/builds/slave/test/build/application/firefox/firefox http://localhost:59480/getInfo.html) 14:10:41 INFO - TEST-INFO | 3289: killed by SIGTERM 14:10:42 INFO - Browser initialized. 14:10:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:42 INFO - TEST-INFO | started process 3485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoc3_UI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:54 INFO - PID 3485 | RSS: Main: 168329216 14:10:54 INFO - PID 3485 | 14:13:58 INFO - PID 3485 | Cycle 1(1): loaded http://localhost:59480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59480/tests/dromaeo/cssquery-ext.html) 14:13:59 INFO - PID 3485 | RSS: Main: 165531648 14:13:59 INFO - PID 3485 | 14:17:01 INFO - PID 3485 | Cycle 1(1): loaded http://localhost:59480/tests/dromaeo/cssquery-ext.html (next: http://localhost:59480/tests/dromaeo/cssquery-jquery.html) 14:17:02 INFO - PID 3485 | RSS: Main: 171540480 14:17:02 INFO - PID 3485 | 14:20:03 INFO - PID 3485 | Cycle 1(1): loaded http://localhost:59480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59480/tests/dromaeo/cssquery-mootools.html) 14:20:04 INFO - PID 3485 | RSS: Main: 170471424 14:20:04 INFO - PID 3485 | 14:23:06 INFO - PID 3485 | Cycle 1(1): loaded http://localhost:59480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59480/tests/dromaeo/cssquery-prototype.html) 14:23:06 INFO - PID 3485 | RSS: Main: 173809664 14:23:06 INFO - PID 3485 | 14:26:09 INFO - PID 3485 | Cycle 1(1): loaded http://localhost:59480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59480/tests/dromaeo/cssquery-yui.html) 14:26:10 INFO - PID 3485 | RSS: Main: 172990464 14:26:10 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | Cycle 1(1): loaded http://localhost:59480/tests/dromaeo/cssquery-yui.html (next: http://localhost:59480/tests/dromaeo/cssquery-dojo.html) 14:29:12 INFO - PID 3485 | RSS: Main: 170778624 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | __start_tp_report 14:29:12 INFO - PID 3485 | _x_x_mozilla_page_load 14:29:12 INFO - PID 3485 | _x_x_mozilla_page_load_details 14:29:12 INFO - PID 3485 | |i|pagename|runs| 14:29:12 INFO - PID 3485 | |0;dojo.html;2720.088770261962;2737.8494182819936;2763.392053748176;2772.7781777457794;2781.8330900145993;5065.037642847857;5145.6398052136365;5159.484051594839;5188.195829646402;5205.843824685261;5074.391073071228;5153.74231288435;5174.249733788598;5214.530692237698;5228.895422091556;4595.471520775121;4604.240300350455;4619.6997195182375;4640.257558790594;4648.279516674921;4612.262038073909;4639.420072490939;4640.837570685027;4654.906901861961;4674;4562.133194692998;4626.074785043005;4626.745528995903;4666.9766651166865;4681.204195286809;4585.908281834378;4601.447826260836;4652.883677908046;4661.230896902007;4674.859754207345;4563.771811409416;4572.359869618256;4574.852200134893;4577.06170235101;4629.791659375336;5114;5154.664946778447;5184.792608295664;5192.506711862367;5201.089809283398;5583.916241256385;5601.887962240773;5602.579806514527;5610.354809196954;5673.3475650299915;5625.943740562583;5647.0964645656495;5682.204491371212;5682.460166284196;5691.8292451226525;5229.764660590283;5259.132243179833;5270.130428479296;5272.789088436496;5279.498447647467;5933.050711886078;5977.641341519523;6002.579819412599;6089.817305480843;6090.512758979271;5454.318210223722;5516.117421212587;5517.862053448615;5527.088030475007;5562.3047119110115;5615;5620.775168993195;5631.915521267184;5640.32316122068;5648.774049037993;5502.0921547944945;5514.724263786795;5596.720163991784;5632.831015069554;5636.436356364331;5590.552755779528;5640.661560306395;5671.829845104653;5681.403452637496;5692.715364231772;4832.63755218353;4844.442889067803;4846.539578740014;4846.573270715624;4876.5854902333695;3928.8624898129;3993.0616305168264;4001;4003.839846406111;4028.295048366524;4903.190973489334;4932.876678083005;4944.653874228769;4980.601551875841;5002.624803139779;5608.439156084359;5613.186088017214;5625.859353516113;5637.7181140942785;5669.744861481243;4962.6774259673;4965.329680493087;4965.503449655078;4967.82612608557;5017;4972.303877457159;5011.398632164163;5038.571721403721;5097.668651537638;5131.25596788471;5494.670319780826;5503.064479038493;5503.669779813224;5534.308211473566;5538.058530049821;5529.751161197836;5603.635763675348;5628.60599758013;5630.071038278802;5644.238027866186;5361.115415956324;5423.105187643994;5439.48324909133;5447.291852059207;5457.727113644222;5381.5694744421135;5527.447255274601;5532.2254884317035;5536;5550.417206193291;5489.176623506506;5556.555475561864;5575.776968921197;5618.325800903917;5648.322201335866;5442.482964118402;5451.64564303319;5458.181272809111;5461.235427040297;5462;5467.933752918143;5469.097598896296;5470.042742520122;5479.945200547943;5519.66881987066;5273.920891186559;5308.389535203347;5357.678539287655;5378.515933565998;5421.5391691706645;5478.643888147258;5511.862203444946;5514.035043867227;5514.834554963358;5528.419515950767;5299.6290259681455;5300.178472336794;5308.628396012242;5309.150535914389;5314.760835762478 14:29:12 INFO - PID 3485 | |1;ext.html;696.5402834129474;705.4356514788168;1072.1797824664134;1089.6022951622656;1192.8986036186923;33496;33946.99999999997;33980;34004.829975850116;34007.999999999935;32032.35935281299;32211;32336;32369.190770230754;32428.837855810747;6435.774747883836;6561.606303621774;6648.567843090208;6856.451483881303;6856.691448884787;6699.866002679943;6725.05849181115;6801.4558835293055;6803;6810.557313774613;6784.457243420515;6794.218664853531;6797.320267973212;6820.35206655367;6832.145981752281;6730.057791909087;6767.932320676804;6771.864562708718;6778;6783.559068660546;6710.597364158166;6762.3237676232475;6770.052192693027;6773.221079575863;6776.15298087739;32385.352292954245;32390;32408.837955810304;32615;32712;3005.038387715932;3061.6479104902774;3065.080475857234;3068.2636167319683;3072.585200997881;24876.3780905477;25045.24864254075;25171.87414062918;25179.496410071697;25226.117085901904;2954.4681957247685;2966.688497707753;2971.1235185620294;2985.7163569461086;3034.2717747740603;141788;142319;142979.28510357486;142990;143029.2848535761;37848.62151378451;39402.21195576072;39562.2087558253;39752.80123599363;40708.38937415882;41044.38433423501;41142.79428602898;41257.1748565027;41291.38062929059;41381.37927931084;11895.107866910017;11906.642800715992;11952.223105498115;11969;11997.760044799055;9444.291678124167;9455.723477330472;9458;9466.763330916645;9473.336866419284;12533.060020498498;12559.246445213133;12573.057020723483;12600.4329805159;12705.618831435071;5070.442251352349;5076.416212135578;5117.897642047138;5142.382914050338;5193.37679478465;865.2515574028546;892.9508877011826;895.5566994337845;899.3344924755764;912.5072460871188;20232.44817202172;21092.683609745865;21334.893325533583;21406.892965535386;21582.136714531556;962.5091203486272;963.8939716631165;965.5027660754716;969.583079275904;982.2387649571497;11336.489857956412;13915.30423478822;14319.156655848257;14700;14804.925975370053;170116;170294;170978;171320;172084;44090.33864492035;44091.77954110273;44339.33490997637;44364.334534982;44450.55549444464;1215.1979693402488;1245.7757603631433;1251.3367915005063;1253.5800506830133;1254.6612414647993;23930.760692392854;24533.14134005301;24951.500969980134;25228.621570676823;25513.23460296194;29497.410051798415;29576.852115739282;29821;29831;29858.552121717756;153893;154797.22601386922;154937;155073;155560.55515558503;28552;28843.711562884102;29214.123576292746;29666.703332966394;30450.39099217959;35607.82196089003;36222.09444763902;36331.27337453289;36780.63219367879;37152;26834;27271.454570908867;27459.31351716223;27626.0330888426;28555.571666425436;26939.326516837235;27549;27684;28425.147245582666;29412;30381.544276835422;30544.08367748971;30864.845675771478;31048;31277;26874.865625671748;27677.723222767516;27698.86150569234;28403.857980709963;28518;20412.489687757923;22320;22413.43966400853;22458.10167593278;22499.887500562392 14:29:12 INFO - PID 3485 | |2;jquery.html;403.6891593473024;407.8022159252762;416.1718180820169;427.45499488152603;436.2910270809934;12613.810792838114;17382.21780019899;18002.90998545007;18057.097145142758;18156.45530634083;18527.629447411044;18597.7210341845;18767.62464750704;18793.060346982664;18894.244230230775;5322.33470816148;5456.454354564551;5492.093804522249;5522.475364840334;5548;5211.973940130294;5416.647917885344;5427.213054107152;5427.348718153827;5427.565794736432;5162.974185129069;5389.245505629215;5393.325834270716;5399.784008639669;5408.8377348679605;5297.682139071649;5348.251244825728;5387.649802762828;5395.190721391783;5404.270423492818;4790.688605240648;4833;4833.758312084382;4842.588379987706;4863.440704318978;21131.154753809984;21311;21340.5731885363;21691;21752.12991480339;1609.8309677483812;1651.306451290461;1673.063084672575;1674.673438679458;1674.9162541872859;14334.28328583577;14357;14525.491607793781;14537.491187808482;14670.19313937733;2034.8473864460225;2051.3538235455785;2123.893805309728;2126.479012641897;2130.968035479469;80073;80166.19833801646;80177;81055;81447.59276203581;10452.634157804441;10687.14502839771;10733.08768754649;10867.510962006729;10961.506732197071;14446.422143114369;15171.924140379448;15199.62000949963;15205;15219.467318644016;7614.505057171377;7790.649420776079;7931.127575966639;7954.244346787046;7982.521048737094;7202.855942881113;7211.963940180371;7250.854982900312;7416.184219735825;7441.367483763833;6856.41720453767;6875.48433867462;6891.75878844238;6979.755708550278;7128.786136415916;1939.6896496560482;1947.7857435682063;1960.0501245625528;1963.4894927319;2078.293380250722;827.9006519217733;840.4663038970176;840.7771940435789;871.422724867991;882.4572887674034;16209.83790162107;17048.82951170497;17082.914585426992;17114.315427383015;17186.74219886703;875.7504111328368;879.6497376527128;890.2744263425287;904.412132114118;909.4588719711761;9034.683786067457;9354.859677104849;9413.435193888388;9442.462643749817;9451.432914025181;364250;364379;367140;367217;367419;76799.61600192075;79852;80044.19955800484;80260.19739802527;81723;1037.6420135053395;1063.7393838509615;1108.146727020206;1112.8052590796578;1114.6990312615549;16833.579160520596;17375;17948.730769038735;18065.819341806415;18203.817961820743;38987.6101238984;39032.41451378288;39195;39362;40170.79914600525;48282.275765864244;50116.49883501118;50702.49297506978;51227.2315915269;51842;8190.385721070825;8224.465409748347;8407.2433480987;8416.621252043795;8622.396432249683;11705.648830535098;12061.51753929868;12402.5659101931;12628.305443200712;12794;10100.898991009995;10284.845727313947;10415.68752937413;10453.9477302613;10468.947655261674;9498.050194980724;9608.327417081016;9641.517924103908;9765.267604929517;9774.511274436392;10177.694669159937;10196.133328667147;10300.549315979231;10710.464476776286;10923.016928476476;8073.475224110414;8168.428210025241;8299.626516806878;8304.584770761317;8569.885914831031;10609.20430967696;10648.467576620984;10884.115709337191;10956.835647465135;10999.23005389615 14:29:12 INFO - PID 3485 | |3;mootools.html;1264.63957772035;1322.550332886819;1329.5811819276933;1333.7399207154597;1336.0714303559027;10396.844047339286;10761.08530774885;10936.890631093696;10966.506507207176;10970.780584388307;10649.57401703933;10864.891351086486;10878.510467028982;10889.292196007254;10889.455527223627;2204.3137000194865;2253.5718213539376;2258.6386178211487;2266.75065742769;2270.6707527408516;2080.916763329465;2118.258609486675;2121.1833444124045;2122.2359950417836;2130;2100.096958307927;2145.5387091775265;2156.956860862782;2161.6541353383464;2161.9243326483574;2095.5704080663427;2095.8218551423147;2101.338078505266;2105.52625659227;2109.440998135495;2105.105330234644;2143.721316228896;2232.2745107839855;2249.3139592424304;2254.1546919905036;10676.893231067668;10745.301555398873;10773.299735517166;10780;10790.136789056856;5618.353889302701;5805;5825;5832.1834943108;5853.5902486825935;3293.6047674279002;3364.360771453416;3383;3431.725461963037;3432.056184549244;1121.43928035982;1126.1947707389174;1147.8737338892715;1173.9354335511543;1181.2144923625779;15924;16080.517584472485;16081.758773618405;16101.597460063358;16148.111853848033;4625.213713668684;4671.089137618132;4805.831795887197;4857.732824694605;4866.926996095061;11404;11405.26273694324;11411.771764564663;11414.201005929672;11461;5478.205660179252;5574.86062848432;5604.971975140098;5610.607257492018;5622.128570071645;5114.105031619451;5222.112240919053;5239.580833533309;5242.266082748418;5258.868528286747;3929.6070392960473;4044.7753735445385;4090.2433049885867;4115.855945041969;4135.255653982312;1123.5786580032488;1137.1073707139856;1137.306243191669;1143.388287266325;1151.4300421291348;705.3052743048094;728.1517032657001;732.9816754581178;736.9226231245749;741.7737590035091;5568.805091821767;5607.243022192033;5674.290713660793;5695.715214239354;5757.6833274169485;532.3824363738046;555.303094616254;561.4946548106655;563.4196777319286;563.5885803363567;3386.8306584670668;3478.826058697055;3561.5904171020666;3685.631436856293;3958.465607142999;13689.726205475834;13821.239831809145;14110.294485275695;14124.788128178085;14155.787663185061;13855.653608659662;14018.158910465405;14057.507987220399;14066.226357550433;14137.434502619986;7257.709691612276;7461.910665013805;7731.840223966337;7738.922610773933;7792.181820908836;5809.24479817621;6080.0575910733905;6091.086337049478;6095.725692343766;6355.459785918249;12506.874931250572;12593.559225427067;12635.557755478514;12884.935575322439;12949.093563450468;12593.748125037631;12989.545365912149;12999.545015924397;13134.343282836011;13173.670658233237;8386.825844381914;8604.182602652738;8644.481331120152;8649.3512986525;8663.48019118855;10022.498875056364;10065.647702330383;10095.54570044335;10158.542865570918;10172.440515771703;8474.957625211835;8585.570721463777;8615.784605384664;8655.87016194745;8818.030016698287;8241.093479717107;8269.95865020671;8300.87548686758;8331.541765202972;8410.369222308229;7756.108047574376;7838.372930165687;7870.212978702084;7873.921260787319;7889.250521200477;5309.601779866448;5490.0941344677685;5687.829365119053;5702.173184888251;5755.381301507888;5530.446955304437;5530.72793257545;5559;5581.855719577396;5652.3217213934595 14:29:12 INFO - PID 3485 | |4;prototype.html;371.6655010490558;372.15335112618806;374.33181770539585;375.6581510825148;378.4663624289751;5189.247559103937;5192.014591609825;5206.583473322139;5252.422233554306;5338.439463856297;5045.545900868921;5147.305113809634;5165.483451654833;5180.896382072357;5186.559142472895;3865.9613403866024;3924.5879182685762;3974.4237085622567;3979.6418322350983;3991.6008399159996;3983.8207280672295;3986.3223252047223;3986.9800650996704;3990.102226998931;3990.980045099785;3921.3333733265413;3922.921541569167;3937.3897045957924;3939.704522160835;3965.9801700991457;3820.331441997639;3939.5469521005166;3944.2703099926607;3951.9209615807667;3959.3467077932105;3425.794452332868;3435.484677298425;3445.913852153691;3447.7414193935556;3458.913527161816;5097.004935163561;5116.411612664554;5151.201563757623;5194.402643695986;5203.349581302337;4589.931151032737;4663.300504924255;4670.813167473297;4676.95323046772;4684.344191813149;5548.4174161713245;5558.221848941152;5561.332640083176;5569.164625306196;5573.916391254134;3855.8264878080554;3875.9031024224337;3876.573576906538;3884.9805750971345;3885.2423777363424;5527.226188333637;5939.663575695477;6119.724612392453;6192;6201.255849298068;3922.7254092213843;3933.6822164574614;3949.289127956938;3954.406838974177;3954.8022598869943;3945.743526670757;3992.301347264275;3995.5604883462797;4001.7198796083994;4007.5591684914634;4615.769211539409;4617.083910177306;4618.35343051973;4620.514845941195;4638.1883170445035;5502.147167189092;5576.832695019156;5640.689762063126;5641.323041235078;5660.603757736919;1368.3910659756314;1369.1579678497653;1375.9036867419184;1379.2896658221025;1388.6597783543098;895.0557162193818;898.9910100899039;934.2759361494896;935.3919952031234;937.3438592984937;5053.418856831511;5055.064813009605;5061.139606266944;5072.061668591248;5079.415867175248;5659.179418984224;5712.2288491054005;5733.111367738007;5735.684537350486;5736.196932429463;4908.582770464551;4953.554180123806;5002.1496345621335;5002.473256354261;5013.1227035268685;2986.5818785370066;3013;3017.9849100754354;3018.879244830226;3033.8028028178096;5504.504594586507;5507.834764957058;5557.833265002057;5574.247476590689;5579.776808927598;5699.857503562361;5744.224529688522;5756.798512052142;5805.535557155417;5834.24154859874;5652.9152062719095;5655.462731040545;5666.631668941505;5670.036093863971;5685.886282274414;5733.655980641175;5745.9425405745405;5748.706541028402;5780.3352614448195;5785.768569257351;5599;5750.568707346882;5775.711214439345;5817.214676018683;5819.883602328015;5611.597100724819;5634.887302254014;5642.774289028393;5658.207850900795;5671.489565939085;3831.310364134371;3884.533855937306;3924.843006279831;3930.587288334798;3933.92132157361;5716.742746576331;5728;5746.798862039808;5765.769369225184;5814.563907707024;5538.252335934597;5571.9442805571425;5605.523530499953;5606.719664016864;5610.5231055360755;5352.9732351338;5500.367457742251;5510.9448905510435;5566.304211973504;5576.804811831728;5464.743109085012;5491.890162196813;5503.3395992481155;5518.9921492785725;5524.281843360337;5402.324709411324;5590.888182236251;5611.390703322974;5628.127640215773;5656.208130861601;5423.430539793265;5432.837014889559;5440.347158341025;5451.863703407446;5466.480684334982 14:29:12 INFO - PID 3485 | |5;yui.html;675.2538445018258;705.1115594351119;750.0736590310966;753.314483819724;779.236348378589;13636.454541818328;14827.184504852228;14908.701825963488;16236.75644865328;16919.238634261455;16699.666006679858;16806.32774689011;16817.495475135765;16825.495235142935;16840.410585629506;896.932730045246;909.8817153770001;927.4574373991223;928.4475736936512;931.6273490603779;928.9581968811386;929.9581518831669;936.063936063936;936.9063093690645;937.6858752317981;954.5131982688844;957.0238356875982;961.4808003678005;965.0205041882494;965.2808657550135;955.6846240740539;958.089814676057;958.7123862841155;959.1415682963778;961.2262128986198;699.3880354689646;701.2076353720314;706.0362605044129;708.518207618819;709.0392518137952;14835.184064876428;14900.70198596022;15072.397104115931;15082.622934426618;15092.245387730569;15119.470818521298;15459.458918937784;15487.612809679735;15595;15599.454019109391;12226.938865305705;12314.13801033928;12379.257244565355;12565.371731413392;12574.74850502994;3035.620547431571;3038.3619439917643;3062.525308577174;3067.938641227163;3070.846457677107;85486.5725671374;86164.56917715434;86480;87097;88920;12395.75208495825;12429;12507.874921250854;12574;12600.684982875318;23376.53246935086;23846.403839904142;23921.28236152918;23937.52124957526;23970.40073998164;6597.769078082244;6675.86648267032;6867.278935711778;6905.067815844897;6905.689243983932;3129.1551281154416;3144.8427578620976;3164.335489547175;3167.113208301679;3170.270837707294;3898.4152377143655;3983.820728067186;3986.5415477219913;3988.900277493086;3990.341593637075;762.7521055656933;788.9526628402314;800.2997377294867;801.2308184143287;802.5505716798612;607.183338409838;613.8311964209789;617.0466629058116;617.3579477343512;633.4014356433127;9859.605615775288;10301.587936482607;10610.787784244427;10625.574977000833;11066.889331106748;598.7365559153958;607.8146165419589;617.7899514165206;624.8250489862845;626.4362074133226;4629.629629629621;4855.684380515255;4886.120498310267;4923.113839508851;5075.746212689424;84450.57774711087;85179.57410212909;85704;85768.57115714507;85937.57031214803;73048.63475682588;73507.63246183735;74389.6280518594;74516.62741686257;74801;64921.999999999054;65056.67471662706;65242;65459;65938.34061659419;9273.67542136022;10001.249906257206;10029.949850250701;10080.24398170155;10123.7469063274;29462.11613651594;29755.55366669545;29841.701582984762;30165;30908.845455772578;37855;38285.808570956964;38328;38937.2212555753;39016.60983390243;12687.936560317139;12694;12898.806517902427;13065.804012940003;13114.868851311747;14284.214368209849;14469;14909.776353354491;15371.84628153749;15644.608884777972;14189.929050354682;14306.427742890168;14571.781423278448;14640.26798660084;14779.556613301618;16048.919755401148;16083.678326433639;16123.67752644964;16167.353305867633;16406.09766462856;14657.120572765669;14664.706705866036;14828;14890.329935152728;15042.473513427416;11156.386398748147;11257.354521687561;11572.6528204154;11760.235584686969;11952.76094478123;12004.39978001079;12537.874621254035;12680.795324444163;12689.365531723191;12736.790004949515 14:29:12 INFO - PID 3485 | __end_tp_report 14:29:12 INFO - PID 3485 | __start_cc_report 14:29:12 INFO - PID 3485 | _x_x_mozilla_cycle_collect,340 14:29:12 INFO - PID 3485 | __end_cc_report 14:29:12 INFO - PID 3485 | __startTimestamp1495747752254__endTimestamp 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | ------- Summary: start ------- 14:29:12 INFO - PID 3485 | Number of tests: 6 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | [#0] dojo.html Cycles:165 Average:5166.23 Median:5357.68 stddev:606.83 (11.3%) stddev-sans-first:577.55 14:29:12 INFO - PID 3485 | Values: 2720.1 2737.8 2763.4 2772.8 2781.8 5065.0 5145.6 5159.5 5188.2 5205.8 5074.4 5153.7 5174.2 5214.5 5228.9 4595.5 4604.2 4619.7 4640.3 4648.3 4612.3 4639.4 4640.8 4654.9 4674.0 4562.1 4626.1 4626.7 4667.0 4681.2 4585.9 4601.4 4652.9 4661.2 4674.9 4563.8 4572.4 4574.9 4577.1 4629.8 5114.0 5154.7 5184.8 5192.5 5201.1 5583.9 5601.9 5602.6 5610.4 5673.3 5625.9 5647.1 5682.2 5682.5 5691.8 5229.8 5259.1 5270.1 5272.8 5279.5 5933.1 5977.6 6002.6 6089.8 6090.5 5454.3 5516.1 5517.9 5527.1 5562.3 5615.0 5620.8 5631.9 5640.3 5648.8 5502.1 5514.7 5596.7 5632.8 5636.4 5590.6 5640.7 5671.8 5681.4 5692.7 4832.6 4844.4 4846.5 4846.6 4876.6 3928.9 3993.1 4001.0 4003.8 4028.3 4903.2 4932.9 4944.7 4980.6 5002.6 5608.4 5613.2 5625.9 5637.7 5669.7 4962.7 4965.3 4965.5 4967.8 5017.0 4972.3 5011.4 5038.6 5097.7 5131.3 5494.7 5503.1 5503.7 5534.3 5538.1 5529.8 5603.6 5628.6 5630.1 5644.2 5361.1 5423.1 5439.5 5447.3 5457.7 5381.6 5527.4 5532.2 5536.0 5550.4 5489.2 5556.6 5575.8 5618.3 5648.3 5442.5 5451.6 5458.2 5461.2 5462.0 5467.9 5469.1 5470.0 5479.9 5519.7 5273.9 5308.4 5357.7 5378.5 5421.5 5478.6 5511.9 5514.0 5514.8 5528.4 5299.6 5300.2 5308.6 5309.2 5314.8 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | [#1] ext.html Cycles:180 Average:30322.55 Median:16802.87 stddev:40351.24 (240.1%) stddev-sans-first:40403.11 14:29:12 INFO - PID 3485 | Values: 696.5 705.4 1072.2 1089.6 1192.9 33496.0 33947.0 33980.0 34004.8 34008.0 32032.4 32211.0 32336.0 32369.2 32428.8 6435.8 6561.6 6648.6 6856.5 6856.7 6699.9 6725.1 6801.5 6803.0 6810.6 6784.5 6794.2 6797.3 6820.4 6832.1 6730.1 6767.9 6771.9 6778.0 6783.6 6710.6 6762.3 6770.1 6773.2 6776.2 32385.4 32390.0 32408.8 32615.0 32712.0 3005.0 3061.6 3065.1 3068.3 3072.6 24876.4 25045.2 25171.9 25179.5 25226.1 2954.5 2966.7 2971.1 2985.7 3034.3 141788.0 142319.0 142979.3 142990.0 143029.3 37848.6 39402.2 39562.2 39752.8 40708.4 41044.4 41142.8 41257.2 41291.4 41381.4 11895.1 11906.6 11952.2 11969.0 11997.8 9444.3 9455.7 9458.0 9466.8 9473.3 12533.1 12559.2 12573.1 12600.4 12705.6 5070.4 5076.4 5117.9 5142.4 5193.4 865.3 893.0 895.6 899.3 912.5 20232.4 21092.7 21334.9 21406.9 21582.1 962.5 963.9 965.5 969.6 982.2 11336.5 13915.3 14319.2 14700.0 14804.9 170116.0 170294.0 170978.0 171320.0 172084.0 44090.3 44091.8 44339.3 44364.3 44450.6 1215.2 1245.8 1251.3 1253.6 1254.7 23930.8 24533.1 24951.5 25228.6 25513.2 29497.4 29576.9 29821.0 29831.0 29858.6 153893.0 154797.2 154937.0 155073.0 155560.6 28552.0 28843.7 29214.1 29666.7 30450.4 35607.8 36222.1 36331.3 36780.6 37152.0 26834.0 27271.5 27459.3 27626.0 28555.6 26939.3 27549.0 27684.0 28425.1 29412.0 30381.5 30544.1 30864.8 31048.0 31277.0 26874.9 27677.7 27698.9 28403.9 28518.0 20412.5 22320.0 22413.4 22458.1 22499.9 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | [#2] jquery.html Cycles:180 Average:24587.69 Median:405.75 stddev:60853.63 (14998.0%) stddev-sans-first:60997.25 14:29:12 INFO - PID 3485 | Values: 403.7 407.8 416.2 427.5 436.3 12613.8 17382.2 18002.9 18057.1 18156.5 18527.6 18597.7 18767.6 18793.1 18894.2 5322.3 5456.5 5492.1 5522.5 5548.0 5212.0 5416.6 5427.2 5427.3 5427.6 5163.0 5389.2 5393.3 5399.8 5408.8 5297.7 5348.3 5387.6 5395.2 5404.3 4790.7 4833.0 4833.8 4842.6 4863.4 21131.2 21311.0 21340.6 21691.0 21752.1 1609.8 1651.3 1673.1 1674.7 1674.9 14334.3 14357.0 14525.5 14537.5 14670.2 2034.8 2051.4 2123.9 2126.5 2131.0 80073.0 80166.2 80177.0 81055.0 81447.6 10452.6 10687.1 10733.1 10867.5 10961.5 14446.4 15171.9 15199.6 15205.0 15219.5 7614.5 7790.6 7931.1 7954.2 7982.5 7202.9 7212.0 7250.9 7416.2 7441.4 6856.4 6875.5 6891.8 6979.8 7128.8 1939.7 1947.8 1960.1 1963.5 2078.3 827.9 840.5 840.8 871.4 882.5 16209.8 17048.8 17082.9 17114.3 17186.7 875.8 879.6 890.3 904.4 909.5 9034.7 9354.9 9413.4 9442.5 9451.4 364250.0 364379.0 367140.0 367217.0 367419.0 76799.6 79852.0 80044.2 80260.2 81723.0 1037.6 1063.7 1108.1 1112.8 1114.7 16833.6 17375.0 17948.7 18065.8 18203.8 38987.6 39032.4 39195.0 39362.0 40170.8 48282.3 50116.5 50702.5 51227.2 51842.0 8190.4 8224.5 8407.2 8416.6 8622.4 11705.6 12061.5 12402.6 12628.3 12794.0 10100.9 10284.8 10415.7 10453.9 10468.9 9498.1 9608.3 9641.5 9765.3 9774.5 10177.7 10196.1 10300.5 10710.5 10923.0 8073.5 8168.4 8299.6 8304.6 8569.9 10609.2 10648.5 10884.1 10956.8 10999.2 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | [#3] mootools.html Cycles:180 Average:6546.27 Median:3328.98 stddev:4333.85 (130.2%) stddev-sans-first:4327.84 14:29:12 INFO - PID 3485 | Values: 1264.6 1322.6 1329.6 1333.7 1336.1 10396.8 10761.1 10936.9 10966.5 10970.8 10649.6 10864.9 10878.5 10889.3 10889.5 2204.3 2253.6 2258.6 2266.8 2270.7 2080.9 2118.3 2121.2 2122.2 2130.0 2100.1 2145.5 2157.0 2161.7 2161.9 2095.6 2095.8 2101.3 2105.5 2109.4 2105.1 2143.7 2232.3 2249.3 2254.2 10676.9 10745.3 10773.3 10780.0 10790.1 5618.4 5805.0 5825.0 5832.2 5853.6 3293.6 3364.4 3383.0 3431.7 3432.1 1121.4 1126.2 1147.9 1173.9 1181.2 15924.0 16080.5 16081.8 16101.6 16148.1 4625.2 4671.1 4805.8 4857.7 4866.9 11404.0 11405.3 11411.8 11414.2 11461.0 5478.2 5574.9 5605.0 5610.6 5622.1 5114.1 5222.1 5239.6 5242.3 5258.9 3929.6 4044.8 4090.2 4115.9 4135.3 1123.6 1137.1 1137.3 1143.4 1151.4 705.3 728.2 733.0 736.9 741.8 5568.8 5607.2 5674.3 5695.7 5757.7 532.4 555.3 561.5 563.4 563.6 3386.8 3478.8 3561.6 3685.6 3958.5 13689.7 13821.2 14110.3 14124.8 14155.8 13855.7 14018.2 14057.5 14066.2 14137.4 7257.7 7461.9 7731.8 7738.9 7792.2 5809.2 6080.1 6091.1 6095.7 6355.5 12506.9 12593.6 12635.6 12884.9 12949.1 12593.7 12989.5 12999.5 13134.3 13173.7 8386.8 8604.2 8644.5 8649.4 8663.5 10022.5 10065.6 10095.5 10158.5 10172.4 8475.0 8585.6 8615.8 8655.9 8818.0 8241.1 8270.0 8300.9 8331.5 8410.4 7756.1 7838.4 7870.2 7873.9 7889.3 5309.6 5490.1 5687.8 5702.2 5755.4 5530.4 5530.7 5559.0 5581.9 5652.3 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | [#4] prototype.html Cycles:180 Average:4607.22 Median:5198.88 stddev:1383.44 (26.6%) stddev-sans-first:1350.30 14:29:12 INFO - PID 3485 | Values: 371.7 372.2 374.3 375.7 378.5 5189.2 5192.0 5206.6 5252.4 5338.4 5045.5 5147.3 5165.5 5180.9 5186.6 3866.0 3924.6 3974.4 3979.6 3991.6 3983.8 3986.3 3987.0 3990.1 3991.0 3921.3 3922.9 3937.4 3939.7 3966.0 3820.3 3939.5 3944.3 3951.9 3959.3 3425.8 3435.5 3445.9 3447.7 3458.9 5097.0 5116.4 5151.2 5194.4 5203.3 4589.9 4663.3 4670.8 4677.0 4684.3 5548.4 5558.2 5561.3 5569.2 5573.9 3855.8 3875.9 3876.6 3885.0 3885.2 5527.2 5939.7 6119.7 6192.0 6201.3 3922.7 3933.7 3949.3 3954.4 3954.8 3945.7 3992.3 3995.6 4001.7 4007.6 4615.8 4617.1 4618.4 4620.5 4638.2 5502.1 5576.8 5640.7 5641.3 5660.6 1368.4 1369.2 1375.9 1379.3 1388.7 895.1 899.0 934.3 935.4 937.3 5053.4 5055.1 5061.1 5072.1 5079.4 5659.2 5712.2 5733.1 5735.7 5736.2 4908.6 4953.6 5002.1 5002.5 5013.1 2986.6 3013.0 3018.0 3018.9 3033.8 5504.5 5507.8 5557.8 5574.2 5579.8 5699.9 5744.2 5756.8 5805.5 5834.2 5652.9 5655.5 5666.6 5670.0 5685.9 5733.7 5745.9 5748.7 5780.3 5785.8 5599.0 5750.6 5775.7 5817.2 5819.9 5611.6 5634.9 5642.8 5658.2 5671.5 3831.3 3884.5 3924.8 3930.6 3933.9 5716.7 5728.0 5746.8 5765.8 5814.6 5538.3 5571.9 5605.5 5606.7 5610.5 5353.0 5500.4 5510.9 5566.3 5576.8 5464.7 5491.9 5503.3 5519.0 5524.3 5402.3 5590.9 5611.4 5628.1 5656.2 5423.4 5432.8 5440.3 5451.9 5466.5 14:29:12 INFO - PID 3485 | 14:29:12 INFO - PID 3485 | [#5] yui.html Cycles:180 Average:17729.22 Median:3165.72 stddev:23160.68 (731.6%) stddev-sans-first:23190.24 14:29:12 INFO - PID 3485 | Values: 675.3 705.1 750.1 753.3 779.2 13636.5 14827.2 14908.7 16236.8 16919.2 16699.7 16806.3 16817.5 16825.5 16840.4 896.9 909.9 927.5 928.4 931.6 929.0 930.0 936.1 936.9 937.7 954.5 957.0 961.5 965.0 965.3 955.7 958.1 958.7 959.1 961.2 699.4 701.2 706.0 708.5 709.0 14835.2 14900.7 15072.4 15082.6 15092.2 15119.5 15459.5 15487.6 15595.0 15599.5 12226.9 12314.1 12379.3 12565.4 12574.7 3035.6 3038.4 3062.5 3067.9 3070.8 85486.6 86164.6 86480.0 87097.0 88920.0 12395.8 12429.0 12507.9 12574.0 12600.7 23376.5 23846.4 23921.3 23937.5 23970.4 6597.8 6675.9 6867.3 6905.1 6905.7 3129.2 3144.8 3164.3 3167.1 3170.3 3898.4 3983.8 3986.5 3988.9 3990.3 762.8 789.0 800.3 801.2 802.6 607.2 613.8 617.0 617.4 633.4 9859.6 10301.6 10610.8 10625.6 11066.9 598.7 607.8 617.8 624.8 626.4 4629.6 4855.7 4886.1 4923.1 5075.7 84450.6 85179.6 85704.0 85768.6 85937.6 73048.6 73507.6 74389.6 74516.6 74801.0 64922.0 65056.7 65242.0 65459.0 65938.3 9273.7 10001.2 10029.9 10080.2 10123.7 29462.1 29755.6 29841.7 30165.0 30908.8 37855.0 38285.8 38328.0 38937.2 39016.6 12687.9 12694.0 12898.8 13065.8 13114.9 14284.2 14469.0 14909.8 15371.8 15644.6 14189.9 14306.4 14571.8 14640.3 14779.6 16048.9 16083.7 16123.7 16167.4 16406.1 14657.1 14664.7 14828.0 14890.3 15042.5 11156.4 11257.4 11572.7 11760.2 11952.8 12004.4 12537.9 12680.8 12689.4 12736.8 14:29:12 INFO - PID 3485 | -------- Summary: end -------- 14:29:12 INFO - PID 3485 | 14:29:12 INFO - TEST-INFO | 3485: exit 0 14:29:13 INFO - TEST-OK | dromaeo_css | took 1148300ms 14:29:13 INFO - TEST-START | kraken 14:29:13 INFO - operating with platform_type : linux_ 14:29:13 INFO - Initialising browser for kraken test... 14:29:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59480/getInfo.html -profile /tmp/tmp9wLlU2/profile 14:29:13 INFO - TEST-INFO | started process 3889 (/builds/slave/test/build/application/firefox/firefox http://localhost:59480/getInfo.html) 14:29:47 INFO - TEST-INFO | 3889: killed by SIGTERM 14:29:47 INFO - Browser initialized. 14:29:47 INFO - Running cycle 1/1 for kraken test... 14:29:47 INFO - TEST-INFO | started process 4083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9wLlU2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:59 INFO - PID 4083 | RSS: Main: 168230912 14:29:59 INFO - PID 4083 | 14:30:02 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59480/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:03 INFO - PID 4083 | RSS: Main: 174317568 14:30:03 INFO - PID 4083 | 14:30:06 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59480/tests/kraken/driver.html?testName=audio-dft) 14:30:06 INFO - PID 4083 | RSS: Main: 172986368 14:30:06 INFO - PID 4083 | 14:30:09 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59480/tests/kraken/driver.html?testName=audio-fft) 14:30:10 INFO - PID 4083 | RSS: Main: 170405888 14:30:10 INFO - PID 4083 | 14:30:12 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59480/tests/kraken/driver.html?testName=audio-oscillator) 14:30:12 INFO - PID 4083 | RSS: Main: 171241472 14:30:12 INFO - PID 4083 | 14:30:14 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:15 INFO - PID 4083 | RSS: Main: 171237376 14:30:15 INFO - PID 4083 | 14:30:18 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59480/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:19 INFO - PID 4083 | RSS: Main: 172339200 14:30:19 INFO - PID 4083 | 14:30:22 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59480/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:23 INFO - PID 4083 | RSS: Main: 171241472 14:30:23 INFO - PID 4083 | 14:30:26 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59480/tests/kraken/driver.html?testName=json-parse-financial) 14:30:27 INFO - PID 4083 | RSS: Main: 171692032 14:30:27 INFO - PID 4083 | 14:30:28 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:29 INFO - PID 4083 | RSS: Main: 172052480 14:30:29 INFO - PID 4083 | 14:30:30 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:31 INFO - PID 4083 | RSS: Main: 172036096 14:30:31 INFO - PID 4083 | 14:30:33 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:34 INFO - PID 4083 | RSS: Main: 172371968 14:30:34 INFO - PID 4083 | 14:30:37 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:38 INFO - PID 4083 | RSS: Main: 172085248 14:30:38 INFO - PID 4083 | 14:30:41 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:41 INFO - PID 4083 | RSS: Main: 172277760 14:30:41 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | Cycle 1(1): loaded http://localhost:59480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59480/tests/kraken/driver.html?testName=ai-astar) 14:30:43 INFO - PID 4083 | RSS: Main: 173867008 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | __start_tp_report 14:30:43 INFO - PID 4083 | _x_x_mozilla_page_load 14:30:43 INFO - PID 4083 | _x_x_mozilla_page_load_details 14:30:43 INFO - PID 4083 | |i|pagename|runs| 14:30:43 INFO - PID 4083 | |0;ai-astar;106;112;113;110;111;111;112;123;112;114 14:30:43 INFO - PID 4083 | |1;audio-beat-detection;161;125;122;169;128;122;121;123;142;125 14:30:43 INFO - PID 4083 | |2;audio-dft;163;165;165;163;166;167;172;163;162;164 14:30:43 INFO - PID 4083 | |3;audio-fft;74;74;73;108;74;74;74;78;94;75 14:30:43 INFO - PID 4083 | |4;audio-oscillator;84;84;104;84;83;82;101;83;84;109 14:30:43 INFO - PID 4083 | |5;imaging-gaussian-blur;114;114;114;115;114;114;114;113;114;113 14:30:43 INFO - PID 4083 | |6;imaging-darkroom;149;150;151;151;151;151;151;151;151;150 14:30:43 INFO - PID 4083 | |7;imaging-desaturate;96;95;95;95;95;95;94;94;95;95 14:30:43 INFO - PID 4083 | |8;json-parse-financial;56;54;56;55;55;57;57;55;57;54 14:30:43 INFO - PID 4083 | |9;json-stringify-tinderbox;57;58;56;58;57;58;58;57;58;57 14:30:43 INFO - PID 4083 | |10;stanford-crypto-aes;87;88;86;86;87;89;91;88;123;86 14:30:43 INFO - PID 4083 | |11;stanford-crypto-ccm;132;133;132;142;145;136;131;140;133;135 14:30:43 INFO - PID 4083 | |12;stanford-crypto-pbkdf2;186;193;207;191;198;192;204;194;188;184 14:30:43 INFO - PID 4083 | |13;stanford-crypto-sha256-iterative;75;72;71;73;73;72;74;73;75;71 14:30:43 INFO - PID 4083 | __end_tp_report 14:30:43 INFO - PID 4083 | __start_cc_report 14:30:43 INFO - PID 4083 | _x_x_mozilla_cycle_collect,905 14:30:43 INFO - PID 4083 | __end_cc_report 14:30:43 INFO - PID 4083 | __startTimestamp1495747843852__endTimestamp 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | ------- Summary: start ------- 14:30:43 INFO - PID 4083 | Number of tests: 14 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.30 (3.8%) stddev-sans-first:3.89 14:30:43 INFO - PID 4083 | Values: 106.0 112.0 113.0 110.0 111.0 111.0 112.0 123.0 112.0 114.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:126.50 stddev:17.62 (13.9%) stddev-sans-first:15.70 14:30:43 INFO - PID 4083 | Values: 161.0 125.0 122.0 169.0 128.0 122.0 121.0 123.0 142.0 125.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.91 (1.8%) stddev-sans-first:2.99 14:30:43 INFO - PID 4083 | Values: 163.0 165.0 165.0 163.0 166.0 167.0 172.0 163.0 162.0 164.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:11.73 (15.8%) stddev-sans-first:12.25 14:30:43 INFO - PID 4083 | Values: 74.0 74.0 73.0 108.0 74.0 74.0 74.0 78.0 94.0 75.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.50 stddev:10.45 (12.5%) stddev-sans-first:10.88 14:30:43 INFO - PID 4083 | Values: 84.0 84.0 104.0 84.0 83.0 82.0 101.0 83.0 84.0 109.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:30:43 INFO - PID 4083 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 114.0 113.0 114.0 113.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 14:30:43 INFO - PID 4083 | Values: 149.0 150.0 151.0 151.0 151.0 151.0 151.0 151.0 151.0 150.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 14:30:43 INFO - PID 4083 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.24 14:30:43 INFO - PID 4083 | Values: 56.0 54.0 56.0 55.0 55.0 57.0 57.0 55.0 57.0 54.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 14:30:43 INFO - PID 4083 | Values: 57.0 58.0 56.0 58.0 57.0 58.0 58.0 57.0 58.0 57.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:87.50 stddev:11.32 (12.9%) stddev-sans-first:11.91 14:30:43 INFO - PID 4083 | Values: 87.0 88.0 86.0 86.0 87.0 89.0 91.0 88.0 123.0 86.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.50 stddev:4.82 (3.6%) stddev-sans-first:4.90 14:30:43 INFO - PID 4083 | Values: 132.0 133.0 132.0 142.0 145.0 136.0 131.0 140.0 133.0 135.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:193.50 stddev:7.44 (3.8%) stddev-sans-first:7.35 14:30:43 INFO - PID 4083 | Values: 186.0 193.0 207.0 191.0 198.0 192.0 204.0 194.0 188.0 184.0 14:30:43 INFO - PID 4083 | 14:30:43 INFO - PID 4083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:1.45 (2.0%) stddev-sans-first:1.32 14:30:43 INFO - PID 4083 | Values: 75.0 72.0 71.0 73.0 73.0 72.0 74.0 73.0 75.0 71.0 14:30:43 INFO - PID 4083 | -------- Summary: end -------- 14:30:43 INFO - PID 4083 | 14:30:44 INFO - TEST-INFO | 4083: exit 0 14:30:44 INFO - TEST-OK | kraken | took 91917ms 14:30:44 INFO - SUITE-END | took 1240s 14:30:45 INFO - Completed test suite (00:20:40) 14:30:45 INFO - javascript benchmark 14:30:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6772.014702266127, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2720.088770261962, 2737.8494182819936, 2763.392053748176, 2772.7781777457794, 2781.8330900145993, 5065.037642847857, 5145.6398052136365, 5159.484051594839, 5188.195829646402, 5205.843824685261, 5074.391073071228, 5153.74231288435, 5174.249733788598, 5214.530692237698, 5228.895422091556, 4595.471520775121, 4604.240300350455, 4619.6997195182375, 4640.257558790594, 4648.279516674921, 4612.262038073909, 4639.420072490939, 4640.837570685027, 4654.906901861961, 4674.0, 4562.133194692998, 4626.074785043005, 4626.745528995903, 4666.9766651166865, 4681.204195286809, 4585.908281834378, 4601.447826260836, 4652.883677908046, 4661.230896902007, 4674.859754207345, 4563.771811409416, 4572.359869618256, 4574.852200134893, 4577.06170235101, 4629.791659375336, 5114.0, 5154.664946778447, 5184.792608295664, 5192.506711862367, 5201.089809283398, 5583.916241256385, 5601.887962240773, 5602.579806514527, 5610.354809196954, 5673.3475650299915, 5625.943740562583, 5647.0964645656495, 5682.204491371212, 5682.460166284196, 5691.8292451226525, 5229.764660590283, 5259.132243179833, 5270.130428479296, 5272.789088436496, 5279.498447647467, 5933.050711886078, 5977.641341519523, 6002.579819412599, 6089.817305480843, 6090.512758979271, 5454.318210223722, 5516.117421212587, 5517.862053448615, 5527.088030475007, 5562.3047119110115, 5615.0, 5620.775168993195, 5631.915521267184, 5640.32316122068, 5648.774049037993, 5502.0921547944945, 5514.724263786795, 5596.720163991784, 5632.831015069554, 5636.436356364331, 5590.552755779528, 5640.661560306395, 5671.829845104653, 5681.403452637496, 5692.715364231772, 4832.63755218353, 4844.442889067803, 4846.539578740014, 4846.573270715624, 4876.5854902333695, 3928.8624898129, 3993.0616305168264, 4001.0, 4003.839846406111, 4028.295048366524, 4903.190973489334, 4932.876678083005, 4944.653874228769, 4980.601551875841, 5002.624803139779, 5608.439156084359, 5613.186088017214, 5625.859353516113, 5637.7181140942785, 5669.744861481243, 4962.6774259673, 4965.329680493087, 4965.503449655078, 4967.82612608557, 5017.0, 4972.303877457159, 5011.398632164163, 5038.571721403721, 5097.668651537638, 5131.25596788471, 5494.670319780826, 5503.064479038493, 5503.669779813224, 5534.308211473566, 5538.058530049821, 5529.751161197836, 5603.635763675348, 5628.60599758013, 5630.071038278802, 5644.238027866186, 5361.115415956324, 5423.105187643994, 5439.48324909133, 5447.291852059207, 5457.727113644222, 5381.5694744421135, 5527.447255274601, 5532.2254884317035, 5536.0, 5550.417206193291, 5489.176623506506, 5556.555475561864, 5575.776968921197, 5618.325800903917, 5648.322201335866, 5442.482964118402, 5451.64564303319, 5458.181272809111, 5461.235427040297, 5462.0, 5467.933752918143, 5469.097598896296, 5470.042742520122, 5479.945200547943, 5519.66881987066, 5273.920891186559, 5308.389535203347, 5357.678539287655, 5378.515933565998, 5421.5391691706645, 5478.643888147258, 5511.862203444946, 5514.035043867227, 5514.834554963358, 5528.419515950767, 5299.6290259681455, 5300.178472336794, 5308.628396012242, 5309.150535914389, 5314.760835762478], "value": 5122.299934021987, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.5402834129474, 705.4356514788168, 1072.1797824664134, 1089.6022951622656, 1192.8986036186923, 33496.0, 33946.99999999997, 33980.0, 34004.829975850116, 34007.999999999935, 32032.35935281299, 32211.0, 32336.0, 32369.190770230754, 32428.837855810747, 6435.774747883836, 6561.606303621774, 6648.567843090208, 6856.451483881303, 6856.691448884787, 6699.866002679943, 6725.05849181115, 6801.4558835293055, 6803.0, 6810.557313774613, 6784.457243420515, 6794.218664853531, 6797.320267973212, 6820.35206655367, 6832.145981752281, 6730.057791909087, 6767.932320676804, 6771.864562708718, 6778.0, 6783.559068660546, 6710.597364158166, 6762.3237676232475, 6770.052192693027, 6773.221079575863, 6776.15298087739, 32385.352292954245, 32390.0, 32408.837955810304, 32615.0, 32712.0, 3005.038387715932, 3061.6479104902774, 3065.080475857234, 3068.2636167319683, 3072.585200997881, 24876.3780905477, 25045.24864254075, 25171.87414062918, 25179.496410071697, 25226.117085901904, 2954.4681957247685, 2966.688497707753, 2971.1235185620294, 2985.7163569461086, 3034.2717747740603, 141788.0, 142319.0, 142979.28510357486, 142990.0, 143029.2848535761, 37848.62151378451, 39402.21195576072, 39562.2087558253, 39752.80123599363, 40708.38937415882, 41044.38433423501, 41142.79428602898, 41257.1748565027, 41291.38062929059, 41381.37927931084, 11895.107866910017, 11906.642800715992, 11952.223105498115, 11969.0, 11997.760044799055, 9444.291678124167, 9455.723477330472, 9458.0, 9466.763330916645, 9473.336866419284, 12533.060020498498, 12559.246445213133, 12573.057020723483, 12600.4329805159, 12705.618831435071, 5070.442251352349, 5076.416212135578, 5117.897642047138, 5142.382914050338, 5193.37679478465, 865.2515574028546, 892.9508877011826, 895.5566994337845, 899.3344924755764, 912.5072460871188, 20232.44817202172, 21092.683609745865, 21334.893325533583, 21406.892965535386, 21582.136714531556, 962.5091203486272, 963.8939716631165, 965.5027660754716, 969.583079275904, 982.2387649571497, 11336.489857956412, 13915.30423478822, 14319.156655848257, 14700.0, 14804.925975370053, 170116.0, 170294.0, 170978.0, 171320.0, 172084.0, 44090.33864492035, 44091.77954110273, 44339.33490997637, 44364.334534982, 44450.55549444464, 1215.1979693402488, 1245.7757603631433, 1251.3367915005063, 1253.5800506830133, 1254.6612414647993, 23930.760692392854, 24533.14134005301, 24951.500969980134, 25228.621570676823, 25513.23460296194, 29497.410051798415, 29576.852115739282, 29821.0, 29831.0, 29858.552121717756, 153893.0, 154797.22601386922, 154937.0, 155073.0, 155560.55515558503, 28552.0, 28843.711562884102, 29214.123576292746, 29666.703332966394, 30450.39099217959, 35607.82196089003, 36222.09444763902, 36331.27337453289, 36780.63219367879, 37152.0, 26834.0, 27271.454570908867, 27459.31351716223, 27626.0330888426, 28555.571666425436, 26939.326516837235, 27549.0, 27684.0, 28425.147245582666, 29412.0, 30381.544276835422, 30544.08367748971, 30864.845675771478, 31048.0, 31277.0, 26874.865625671748, 27677.723222767516, 27698.86150569234, 28403.857980709963, 28518.0, 20412.489687757923, 22320.0, 22413.43966400853, 22458.10167593278, 22499.887500562392], "value": 14577.300625369306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.6891593473024, 407.8022159252762, 416.1718180820169, 427.45499488152603, 436.2910270809934, 12613.810792838114, 17382.21780019899, 18002.90998545007, 18057.097145142758, 18156.45530634083, 18527.629447411044, 18597.7210341845, 18767.62464750704, 18793.060346982664, 18894.244230230775, 5322.33470816148, 5456.454354564551, 5492.093804522249, 5522.475364840334, 5548.0, 5211.973940130294, 5416.647917885344, 5427.213054107152, 5427.348718153827, 5427.565794736432, 5162.974185129069, 5389.245505629215, 5393.325834270716, 5399.784008639669, 5408.8377348679605, 5297.682139071649, 5348.251244825728, 5387.649802762828, 5395.190721391783, 5404.270423492818, 4790.688605240648, 4833.0, 4833.758312084382, 4842.588379987706, 4863.440704318978, 21131.154753809984, 21311.0, 21340.5731885363, 21691.0, 21752.12991480339, 1609.8309677483812, 1651.306451290461, 1673.063084672575, 1674.673438679458, 1674.9162541872859, 14334.28328583577, 14357.0, 14525.491607793781, 14537.491187808482, 14670.19313937733, 2034.8473864460225, 2051.3538235455785, 2123.893805309728, 2126.479012641897, 2130.968035479469, 80073.0, 80166.19833801646, 80177.0, 81055.0, 81447.59276203581, 10452.634157804441, 10687.14502839771, 10733.08768754649, 10867.510962006729, 10961.506732197071, 14446.422143114369, 15171.924140379448, 15199.62000949963, 15205.0, 15219.467318644016, 7614.505057171377, 7790.649420776079, 7931.127575966639, 7954.244346787046, 7982.521048737094, 7202.855942881113, 7211.963940180371, 7250.854982900312, 7416.184219735825, 7441.367483763833, 6856.41720453767, 6875.48433867462, 6891.75878844238, 6979.755708550278, 7128.786136415916, 1939.6896496560482, 1947.7857435682063, 1960.0501245625528, 1963.4894927319, 2078.293380250722, 827.9006519217733, 840.4663038970176, 840.7771940435789, 871.422724867991, 882.4572887674034, 16209.83790162107, 17048.82951170497, 17082.914585426992, 17114.315427383015, 17186.74219886703, 875.7504111328368, 879.6497376527128, 890.2744263425287, 904.412132114118, 909.4588719711761, 9034.683786067457, 9354.859677104849, 9413.435193888388, 9442.462643749817, 9451.432914025181, 364250.0, 364379.0, 367140.0, 367217.0, 367419.0, 76799.61600192075, 79852.0, 80044.19955800484, 80260.19739802527, 81723.0, 1037.6420135053395, 1063.7393838509615, 1108.146727020206, 1112.8052590796578, 1114.6990312615549, 16833.579160520596, 17375.0, 17948.730769038735, 18065.819341806415, 18203.817961820743, 38987.6101238984, 39032.41451378288, 39195.0, 39362.0, 40170.79914600525, 48282.275765864244, 50116.49883501118, 50702.49297506978, 51227.2315915269, 51842.0, 8190.385721070825, 8224.465409748347, 8407.2433480987, 8416.621252043795, 8622.396432249683, 11705.648830535098, 12061.51753929868, 12402.5659101931, 12628.305443200712, 12794.0, 10100.898991009995, 10284.845727313947, 10415.68752937413, 10453.9477302613, 10468.947655261674, 9498.050194980724, 9608.327417081016, 9641.517924103908, 9765.267604929517, 9774.511274436392, 10177.694669159937, 10196.133328667147, 10300.549315979231, 10710.464476776286, 10923.016928476476, 8073.475224110414, 8168.428210025241, 8299.626516806878, 8304.584770761317, 8569.885914831031, 10609.20430967696, 10648.467576620984, 10884.115709337191, 10956.835647465135, 10999.23005389615], "value": 8737.227485937552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.63957772035, 1322.550332886819, 1329.5811819276933, 1333.7399207154597, 1336.0714303559027, 10396.844047339286, 10761.08530774885, 10936.890631093696, 10966.506507207176, 10970.780584388307, 10649.57401703933, 10864.891351086486, 10878.510467028982, 10889.292196007254, 10889.455527223627, 2204.3137000194865, 2253.5718213539376, 2258.6386178211487, 2266.75065742769, 2270.6707527408516, 2080.916763329465, 2118.258609486675, 2121.1833444124045, 2122.2359950417836, 2130.0, 2100.096958307927, 2145.5387091775265, 2156.956860862782, 2161.6541353383464, 2161.9243326483574, 2095.5704080663427, 2095.8218551423147, 2101.338078505266, 2105.52625659227, 2109.440998135495, 2105.105330234644, 2143.721316228896, 2232.2745107839855, 2249.3139592424304, 2254.1546919905036, 10676.893231067668, 10745.301555398873, 10773.299735517166, 10780.0, 10790.136789056856, 5618.353889302701, 5805.0, 5825.0, 5832.1834943108, 5853.5902486825935, 3293.6047674279002, 3364.360771453416, 3383.0, 3431.725461963037, 3432.056184549244, 1121.43928035982, 1126.1947707389174, 1147.8737338892715, 1173.9354335511543, 1181.2144923625779, 15924.0, 16080.517584472485, 16081.758773618405, 16101.597460063358, 16148.111853848033, 4625.213713668684, 4671.089137618132, 4805.831795887197, 4857.732824694605, 4866.926996095061, 11404.0, 11405.26273694324, 11411.771764564663, 11414.201005929672, 11461.0, 5478.205660179252, 5574.86062848432, 5604.971975140098, 5610.607257492018, 5622.128570071645, 5114.105031619451, 5222.112240919053, 5239.580833533309, 5242.266082748418, 5258.868528286747, 3929.6070392960473, 4044.7753735445385, 4090.2433049885867, 4115.855945041969, 4135.255653982312, 1123.5786580032488, 1137.1073707139856, 1137.306243191669, 1143.388287266325, 1151.4300421291348, 705.3052743048094, 728.1517032657001, 732.9816754581178, 736.9226231245749, 741.7737590035091, 5568.805091821767, 5607.243022192033, 5674.290713660793, 5695.715214239354, 5757.6833274169485, 532.3824363738046, 555.303094616254, 561.4946548106655, 563.4196777319286, 563.5885803363567, 3386.8306584670668, 3478.826058697055, 3561.5904171020666, 3685.631436856293, 3958.465607142999, 13689.726205475834, 13821.239831809145, 14110.294485275695, 14124.788128178085, 14155.787663185061, 13855.653608659662, 14018.158910465405, 14057.507987220399, 14066.226357550433, 14137.434502619986, 7257.709691612276, 7461.910665013805, 7731.840223966337, 7738.922610773933, 7792.181820908836, 5809.24479817621, 6080.0575910733905, 6091.086337049478, 6095.725692343766, 6355.459785918249, 12506.874931250572, 12593.559225427067, 12635.557755478514, 12884.935575322439, 12949.093563450468, 12593.748125037631, 12989.545365912149, 12999.545015924397, 13134.343282836011, 13173.670658233237, 8386.825844381914, 8604.182602652738, 8644.481331120152, 8649.3512986525, 8663.48019118855, 10022.498875056364, 10065.647702330383, 10095.54570044335, 10158.542865570918, 10172.440515771703, 8474.957625211835, 8585.570721463777, 8615.784605384664, 8655.87016194745, 8818.030016698287, 8241.093479717107, 8269.95865020671, 8300.87548686758, 8331.541765202972, 8410.369222308229, 7756.108047574376, 7838.372930165687, 7870.212978702084, 7873.921260787319, 7889.250521200477, 5309.601779866448, 5490.0941344677685, 5687.829365119053, 5702.173184888251, 5755.381301507888, 5530.446955304437, 5530.72793257545, 5559.0, 5581.855719577396, 5652.3217213934595], "value": 4820.97031925916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.6655010490558, 372.15335112618806, 374.33181770539585, 375.6581510825148, 378.4663624289751, 5189.247559103937, 5192.014591609825, 5206.583473322139, 5252.422233554306, 5338.439463856297, 5045.545900868921, 5147.305113809634, 5165.483451654833, 5180.896382072357, 5186.559142472895, 3865.9613403866024, 3924.5879182685762, 3974.4237085622567, 3979.6418322350983, 3991.6008399159996, 3983.8207280672295, 3986.3223252047223, 3986.9800650996704, 3990.102226998931, 3990.980045099785, 3921.3333733265413, 3922.921541569167, 3937.3897045957924, 3939.704522160835, 3965.9801700991457, 3820.331441997639, 3939.5469521005166, 3944.2703099926607, 3951.9209615807667, 3959.3467077932105, 3425.794452332868, 3435.484677298425, 3445.913852153691, 3447.7414193935556, 3458.913527161816, 5097.004935163561, 5116.411612664554, 5151.201563757623, 5194.402643695986, 5203.349581302337, 4589.931151032737, 4663.300504924255, 4670.813167473297, 4676.95323046772, 4684.344191813149, 5548.4174161713245, 5558.221848941152, 5561.332640083176, 5569.164625306196, 5573.916391254134, 3855.8264878080554, 3875.9031024224337, 3876.573576906538, 3884.9805750971345, 3885.2423777363424, 5527.226188333637, 5939.663575695477, 6119.724612392453, 6192.0, 6201.255849298068, 3922.7254092213843, 3933.6822164574614, 3949.289127956938, 3954.406838974177, 3954.8022598869943, 3945.743526670757, 3992.301347264275, 3995.5604883462797, 4001.7198796083994, 4007.5591684914634, 4615.769211539409, 4617.083910177306, 4618.35343051973, 4620.514845941195, 4638.1883170445035, 5502.147167189092, 5576.832695019156, 5640.689762063126, 5641.323041235078, 5660.603757736919, 1368.3910659756314, 1369.1579678497653, 1375.9036867419184, 1379.2896658221025, 1388.6597783543098, 895.0557162193818, 898.9910100899039, 934.2759361494896, 935.3919952031234, 937.3438592984937, 5053.418856831511, 5055.064813009605, 5061.139606266944, 5072.061668591248, 5079.415867175248, 5659.179418984224, 5712.2288491054005, 5733.111367738007, 5735.684537350486, 5736.196932429463, 4908.582770464551, 4953.554180123806, 5002.1496345621335, 5002.473256354261, 5013.1227035268685, 2986.5818785370066, 3013.0, 3017.9849100754354, 3018.879244830226, 3033.8028028178096, 5504.504594586507, 5507.834764957058, 5557.833265002057, 5574.247476590689, 5579.776808927598, 5699.857503562361, 5744.224529688522, 5756.798512052142, 5805.535557155417, 5834.24154859874, 5652.9152062719095, 5655.462731040545, 5666.631668941505, 5670.036093863971, 5685.886282274414, 5733.655980641175, 5745.9425405745405, 5748.706541028402, 5780.3352614448195, 5785.768569257351, 5599.0, 5750.568707346882, 5775.711214439345, 5817.214676018683, 5819.883602328015, 5611.597100724819, 5634.887302254014, 5642.774289028393, 5658.207850900795, 5671.489565939085, 3831.310364134371, 3884.533855937306, 3924.843006279831, 3930.587288334798, 3933.92132157361, 5716.742746576331, 5728.0, 5746.798862039808, 5765.769369225184, 5814.563907707024, 5538.252335934597, 5571.9442805571425, 5605.523530499953, 5606.719664016864, 5610.5231055360755, 5352.9732351338, 5500.367457742251, 5510.9448905510435, 5566.304211973504, 5576.804811831728, 5464.743109085012, 5491.890162196813, 5503.3395992481155, 5518.9921492785725, 5524.281843360337, 5402.324709411324, 5590.888182236251, 5611.390703322974, 5628.127640215773, 5656.208130861601, 5423.430539793265, 5432.837014889559, 5440.347158341025, 5451.863703407446, 5466.480684334982], "value": 4179.637475497427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.2538445018258, 705.1115594351119, 750.0736590310966, 753.314483819724, 779.236348378589, 13636.454541818328, 14827.184504852228, 14908.701825963488, 16236.75644865328, 16919.238634261455, 16699.666006679858, 16806.32774689011, 16817.495475135765, 16825.495235142935, 16840.410585629506, 896.932730045246, 909.8817153770001, 927.4574373991223, 928.4475736936512, 931.6273490603779, 928.9581968811386, 929.9581518831669, 936.063936063936, 936.9063093690645, 937.6858752317981, 954.5131982688844, 957.0238356875982, 961.4808003678005, 965.0205041882494, 965.2808657550135, 955.6846240740539, 958.089814676057, 958.7123862841155, 959.1415682963778, 961.2262128986198, 699.3880354689646, 701.2076353720314, 706.0362605044129, 708.518207618819, 709.0392518137952, 14835.184064876428, 14900.70198596022, 15072.397104115931, 15082.622934426618, 15092.245387730569, 15119.470818521298, 15459.458918937784, 15487.612809679735, 15595.0, 15599.454019109391, 12226.938865305705, 12314.13801033928, 12379.257244565355, 12565.371731413392, 12574.74850502994, 3035.620547431571, 3038.3619439917643, 3062.525308577174, 3067.938641227163, 3070.846457677107, 85486.5725671374, 86164.56917715434, 86480.0, 87097.0, 88920.0, 12395.75208495825, 12429.0, 12507.874921250854, 12574.0, 12600.684982875318, 23376.53246935086, 23846.403839904142, 23921.28236152918, 23937.52124957526, 23970.40073998164, 6597.769078082244, 6675.86648267032, 6867.278935711778, 6905.067815844897, 6905.689243983932, 3129.1551281154416, 3144.8427578620976, 3164.335489547175, 3167.113208301679, 3170.270837707294, 3898.4152377143655, 3983.820728067186, 3986.5415477219913, 3988.900277493086, 3990.341593637075, 762.7521055656933, 788.9526628402314, 800.2997377294867, 801.2308184143287, 802.5505716798612, 607.183338409838, 613.8311964209789, 617.0466629058116, 617.3579477343512, 633.4014356433127, 9859.605615775288, 10301.587936482607, 10610.787784244427, 10625.574977000833, 11066.889331106748, 598.7365559153958, 607.8146165419589, 617.7899514165206, 624.8250489862845, 626.4362074133226, 4629.629629629621, 4855.684380515255, 4886.120498310267, 4923.113839508851, 5075.746212689424, 84450.57774711087, 85179.57410212909, 85704.0, 85768.57115714507, 85937.57031214803, 73048.63475682588, 73507.63246183735, 74389.6280518594, 74516.62741686257, 74801.0, 64921.999999999054, 65056.67471662706, 65242.0, 65459.0, 65938.34061659419, 9273.67542136022, 10001.249906257206, 10029.949850250701, 10080.24398170155, 10123.7469063274, 29462.11613651594, 29755.55366669545, 29841.701582984762, 30165.0, 30908.845455772578, 37855.0, 38285.808570956964, 38328.0, 38937.2212555753, 39016.60983390243, 12687.936560317139, 12694.0, 12898.806517902427, 13065.804012940003, 13114.868851311747, 14284.214368209849, 14469.0, 14909.776353354491, 15371.84628153749, 15644.608884777972, 14189.929050354682, 14306.427742890168, 14571.781423278448, 14640.26798660084, 14779.556613301618, 16048.919755401148, 16083.678326433639, 16123.67752644964, 16167.353305867633, 16406.09766462856, 14657.120572765669, 14664.706705866036, 14828.0, 14890.329935152728, 15042.473513427416, 11156.386398748147, 11257.354521687561, 11572.6528204154, 11760.235584686969, 11952.76094478123, 12004.39978001079, 12537.874621254035, 12680.795324444163, 12689.365531723191, 12736.790004949515], "value": 7336.448024033243, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 113.0, 110.0, 111.0, 111.0, 112.0, 123.0, 112.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 122.0, 169.0, 128.0, 122.0, 121.0, 123.0, 142.0, 125.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 163.0, 166.0, 167.0, 172.0, 163.0, 162.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 108.0, 74.0, 74.0, 74.0, 78.0, 94.0, 75.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 104.0, 84.0, 83.0, 82.0, 101.0, 83.0, 84.0, 109.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 151.0, 151.0, 151.0, 151.0, 151.0, 151.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 55.0, 55.0, 57.0, 57.0, 55.0, 57.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 58.0, 57.0, 58.0, 58.0, 57.0, 58.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 86.0, 87.0, 89.0, 91.0, 88.0, 123.0, 86.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 132.0, 142.0, 145.0, 136.0, 131.0, 140.0, 133.0, 135.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 193.0, 207.0, 191.0, 198.0, 192.0, 204.0, 194.0, 188.0, 184.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 71.0, 73.0, 73.0, 72.0, 74.0, 73.0, 75.0, 71.0], "value": 72.9, "unit": "score"}]}]} 14:30:45 INFO - Return code: 0 14:30:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:30:45 INFO - # TBPL SUCCESS # 14:30:45 INFO - Running post-action listener: _resource_record_post_action 14:30:45 INFO - [mozharness: 2017-05-25 21:30:45.135386Z] Finished run-tests step (success) 14:30:45 INFO - Running post-run listener: _resource_record_post_run 14:30:45 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 8622080; Write bytes: 414572544; Read time: 2284; Write time: 444156 14:30:45 INFO - TinderboxPrint: CPU usage
12.6% 14:30:45 INFO - TinderboxPrint: I/O read bytes / time
8,622,080 / 2,284 14:30:45 INFO - TinderboxPrint: I/O write bytes / time
414,572,544 / 444,156 14:30:45 INFO - TinderboxPrint: CPU idle
8,757.6 (87.3%) 14:30:45 INFO - TinderboxPrint: CPU user
1,212.5 (12.1%) 14:30:45 INFO - TinderboxPrint: Swap in / out
0 / 0 14:30:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110764032; Read time: 64; Write time: 122476 14:30:45 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 6873088; Write bytes: 303411200; Read time: 2184; Write time: 321656 14:30:45 INFO - Running post-run listener: _upload_blobber_files 14:30:45 INFO - Blob upload gear active. 14:30:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:45 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 14:30:45 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'] 14:30:45 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 14:30:46 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:30:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:30:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:47 INFO - (blobuploader) - INFO - Done attempting. 14:30:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:53 INFO - (blobuploader) - INFO - Done attempting. 14:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:54 INFO - (blobuploader) - INFO - Done attempting. 14:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:55 INFO - (blobuploader) - INFO - Done attempting. 14:30:55 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:55 INFO - Return code: 0 14:30:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e3eb5619ef60d571dca105bf2f49972ce64cdc644fea54a5e9e7390f8163963925fd1766fdfdecc223fd4450de644e0b861db6a2862d636ac03689df02d854a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9991c97eb2bd7cbdf23de01305ad9e6325dc9bd889b61ce18f060a96ab5510e6787d82d3d4f1872f9338622366817ed52624f6c29d07578f8b1a76bb48c4b511", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17ba4c4209d3298a27d353bc8cdd5104bf452d17236bda5eb97c9a55c441798a10820de56752132acfed60346403ccb3955cd9be94fb46c6b7a3eaec2456d3eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5fb8116f3be6e557017ce99b5716b2b62a98a2d9a5e7dae0fa893be97c83fff200faeaf111461669c3116d2a2e51f1b52f38892f182bd8aae96783ad7dae1b7"} 14:30:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:55 INFO - Contents: 14:30:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e3eb5619ef60d571dca105bf2f49972ce64cdc644fea54a5e9e7390f8163963925fd1766fdfdecc223fd4450de644e0b861db6a2862d636ac03689df02d854a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9991c97eb2bd7cbdf23de01305ad9e6325dc9bd889b61ce18f060a96ab5510e6787d82d3d4f1872f9338622366817ed52624f6c29d07578f8b1a76bb48c4b511", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17ba4c4209d3298a27d353bc8cdd5104bf452d17236bda5eb97c9a55c441798a10820de56752132acfed60346403ccb3955cd9be94fb46c6b7a3eaec2456d3eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5fb8116f3be6e557017ce99b5716b2b62a98a2d9a5e7dae0fa893be97c83fff200faeaf111461669c3116d2a2e51f1b52f38892f182bd8aae96783ad7dae1b7"} 14:30:55 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:55 INFO - Copying logs to upload dir... 14:30:55 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.134344 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-25 14:30:55.170516) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 14:30:55.173946) ========= 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=9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364 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/7e3eb5619ef60d571dca105bf2f49972ce64cdc644fea54a5e9e7390f8163963925fd1766fdfdecc223fd4450de644e0b861db6a2862d636ac03689df02d854a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9991c97eb2bd7cbdf23de01305ad9e6325dc9bd889b61ce18f060a96ab5510e6787d82d3d4f1872f9338622366817ed52624f6c29d07578f8b1a76bb48c4b511", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17ba4c4209d3298a27d353bc8cdd5104bf452d17236bda5eb97c9a55c441798a10820de56752132acfed60346403ccb3955cd9be94fb46c6b7a3eaec2456d3eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5fb8116f3be6e557017ce99b5716b2b62a98a2d9a5e7dae0fa893be97c83fff200faeaf111461669c3116d2a2e51f1b52f38892f182bd8aae96783ad7dae1b7"} build_url:https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/P-dSwiUwRgaQiB0H54wtog/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e3eb5619ef60d571dca105bf2f49972ce64cdc644fea54a5e9e7390f8163963925fd1766fdfdecc223fd4450de644e0b861db6a2862d636ac03689df02d854a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9991c97eb2bd7cbdf23de01305ad9e6325dc9bd889b61ce18f060a96ab5510e6787d82d3d4f1872f9338622366817ed52624f6c29d07578f8b1a76bb48c4b511", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17ba4c4209d3298a27d353bc8cdd5104bf452d17236bda5eb97c9a55c441798a10820de56752132acfed60346403ccb3955cd9be94fb46c6b7a3eaec2456d3eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5fb8116f3be6e557017ce99b5716b2b62a98a2d9a5e7dae0fa893be97c83fff200faeaf111461669c3116d2a2e51f1b52f38892f182bd8aae96783ad7dae1b7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 14:30:55.198056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:30:55.198376) ========= 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=9f7544b6a75ada7b6b576032000001a7-1495746468.966278-1746848364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:30:55.283485) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 14:30:55.283807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 14:30:55.284091) ========= ========= Total master_lag: 0.20 =========