builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1495717129.09 results: success (0) revision: e8da7192201e5786614ec49d557e64dffd114ff2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.085439) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.085853) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.086137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.125697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.126034) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 05:58:49-- 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% 224M=0s 2017-05-25 05:58:49 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.273074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.276391) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015240 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:49.326893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 05:58:49.327229) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e8da7192201e5786614ec49d557e64dffd114ff2 --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 e8da7192201e5786614ec49d557e64dffd114ff2 --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=ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 05:58:49,627 truncating revision to first 12 chars 2017-05-25 05:58:49,627 Setting DEBUG logging. 2017-05-25 05:58:49,628 attempt 1/10 2017-05-25 05:58:49,628 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e8da7192201e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 05:58:50,400 unpacking tar archive at: mozilla-central-e8da7192201e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.116529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 05:58:50.460463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:50.460898) ========= script_repo_revision: e8da7192201e5786614ec49d557e64dffd114ff2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:50.461457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:50.461781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 05:58:50.474690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-25 05:58:50.475069) ========= /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=ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:50 INFO - MultiFileLogger online at 20170525 05:58:50 in /builds/slave/test 05:58:50 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 05:58:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:50 INFO - {'append_to_log': False, 05:58:50 INFO - 'base_work_dir': '/builds/slave/test', 05:58:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:58:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:50 INFO - 'branch': 'Firefox-Non-PGO', 05:58:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:50 INFO - 'config_files': ('talos/linux_config.py',), 05:58:50 INFO - 'default_actions': ('clobber', 05:58:50 INFO - 'read-buildbot-config', 05:58:50 INFO - 'download-and-extract', 05:58:50 INFO - 'populate-webroot', 05:58:50 INFO - 'create-virtualenv', 05:58:50 INFO - 'install', 05:58:50 INFO - 'run-tests'), 05:58:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:50 INFO - 'download_minidump_stackwalk': True, 05:58:50 INFO - 'download_symbols': 'ondemand', 05:58:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:50 INFO - 'gecko_profile': False, 05:58:50 INFO - 'gecko_profile_interval': 0, 05:58:50 INFO - 'installer_path': 'installer.exe', 05:58:50 INFO - 'log_level': 'info', 05:58:50 INFO - 'log_name': 'talos', 05:58:50 INFO - 'log_to_console': True, 05:58:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:50 INFO - 'opt_config_files': (), 05:58:50 INFO - 'pip_index': False, 05:58:50 INFO - 'suite': 'dromaeojs-e10s', 05:58:50 INFO - 'system_bits': '32', 05:58:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:50 INFO - 'title': 'talos-linux64-ix-029', 05:58:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:50 INFO - 'use_talos_json': True, 05:58:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:50 INFO - 'work_dir': 'build'} 05:58:50 INFO - [mozharness: 2017-05-25 12:58:50.888471Z] Running clobber step. 05:58:50 INFO - Running pre-action listener: _resource_record_pre_action 05:58:50 INFO - Running main action method: clobber 05:58:50 INFO - rmtree: /builds/slave/test/build 05:58:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:51 INFO - Running post-action listener: _resource_record_post_action 05:58:51 INFO - [mozharness: 2017-05-25 12:58:51.904319Z] Finished clobber step (success) 05:58:51 INFO - [mozharness: 2017-05-25 12:58:51.904418Z] Running read-buildbot-config step. 05:58:51 INFO - Running pre-action listener: _resource_record_pre_action 05:58:51 INFO - Running main action method: read_buildbot_config 05:58:51 INFO - Using buildbot properties: 05:58:51 INFO - { 05:58:51 INFO - "project": "", 05:58:51 INFO - "product": "firefox", 05:58:51 INFO - "who": "bhearsum@mozilla.com", 05:58:51 INFO - "installer_path": "public/build/target.tar.bz2", 05:58:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:58:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:58:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:58:51 INFO - "stage_platform": "linux64", 05:58:51 INFO - "basedir": "/builds/slave/test", 05:58:51 INFO - "buildnumber": 852, 05:58:51 INFO - "platform": "ubuntu64_hw", 05:58:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:58:51 INFO - "slavebuilddir": "test", 05:58:51 INFO - "taskId": "UAcNh4K3TX6t9uK0OakNyA", 05:58:51 INFO - "branch": "mozilla-central", 05:58:51 INFO - "script_repo_revision": "production", 05:58:51 INFO - "revision": "e8da7192201e5786614ec49d557e64dffd114ff2", 05:58:51 INFO - "slavename": "talos-linux64-ix-029", 05:58:51 INFO - "repo_path": "mozilla-central" 05:58:51 INFO - } 05:58:51 INFO - Finding installer, test and symbols from parent task. 05:58:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UAcNh4K3TX6t9uK0OakNyA'}, attempt #1 05:58:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UAcNh4K3TX6t9uK0OakNyA'}, attempt #1 05:58:52 INFO - Task dependencies: WJayXDDIQLG2B5srHbla3A 05:58:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A'}, attempt #1 05:58:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2 05:58:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/test_packages.json 05:58:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.crashreporter-symbols.zip 05:58:53 INFO - Running post-action listener: _resource_record_post_action 05:58:53 INFO - [mozharness: 2017-05-25 12:58:53.264882Z] Finished read-buildbot-config step (success) 05:58:53 INFO - [mozharness: 2017-05-25 12:58:53.265102Z] Running download-and-extract step. 05:58:53 INFO - Running pre-action listener: _resource_record_pre_action 05:58:53 INFO - Running main action method: download_and_extract 05:58:53 INFO - mkdir: /builds/slave/test/build/tests 05:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:53 INFO - trying https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.test_packages.json 05:58:53 INFO - Downloading https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:58:53 INFO - Downloaded 989 bytes. 05:58:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:58:53 INFO - Using the following test package requirements: 05:58:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:58:53 INFO - u'common': [u'target.common.tests.zip'], 05:58:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:58:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:58:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:58:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:58:53 INFO - u'mozbase': [u'target.common.tests.zip'], 05:58:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:58:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:58:53 INFO - u'web-platform': [u'target.common.tests.zip', 05:58:53 INFO - u'target.web-platform.tests.tar.gz'], 05:58:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:58:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:58:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.common.tests.zip 05:58:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:58:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.common.tests.zip into memory 05:58:55 INFO - Content-Length response header: 63524959 05:58:55 INFO - Bytes received: 63524959 05:59:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.common.tests.zip 05:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.common.tests.zip into memory 05:59:07 INFO - Content-Length response header: 63524959 05:59:07 INFO - Bytes received: 63524959 05:59:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.talos.tests.zip 05:59:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:59:19 INFO - Fetch https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.talos.tests.zip into memory 05:59:20 INFO - Content-Length response header: 14411859 05:59:20 INFO - Bytes received: 14411859 05:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:21 INFO - trying https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2 05:59:21 INFO - Downloading https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:59:22 INFO - Downloaded 54033383 bytes. 05:59:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2 05:59:22 INFO - mkdir: /builds/slave/test/properties 05:59:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:22 INFO - Contents: 05:59:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2 05:59:22 INFO - Running post-action listener: _resource_record_post_action 05:59:22 INFO - Running post-action listener: set_extra_try_arguments 05:59:22 INFO - [mozharness: 2017-05-25 12:59:22.786530Z] Finished download-and-extract step (success) 05:59:22 INFO - [mozharness: 2017-05-25 12:59:22.786719Z] Running populate-webroot step. 05:59:22 INFO - Running pre-action listener: _resource_record_pre_action 05:59:22 INFO - Running main action method: populate_webroot 05:59:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:22 INFO - '--tppagecycles', 05:59:22 INFO - '7'], 05:59:22 INFO - 'tests': ['tsvgm']}}, 05:59:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:59:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:59:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:59:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['damp', 'tps']}, 05:59:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'tests': ['damp', 'tps']}, 05:59:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['dromaeo_dom']}, 05:59:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:59:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:59:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:59:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['a11yr', 05:59:22 INFO - 'ts_paint', 05:59:22 INFO - 'tpaint', 05:59:22 INFO - 'sessionrestore', 05:59:22 INFO - 'sessionrestore_no_auto_restore', 05:59:22 INFO - 'tabpaint']}, 05:59:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:59:22 INFO - 'ts_paint', 05:59:22 INFO - 'tpaint', 05:59:22 INFO - 'sessionrestore', 05:59:22 INFO - 'sessionrestore_no_auto_restore', 05:59:22 INFO - 'tabpaint']}, 05:59:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:59:22 INFO - 'ts_paint', 05:59:22 INFO - 'tpaint', 05:59:22 INFO - 'sessionrestore', 05:59:22 INFO - 'sessionrestore_no_auto_restore', 05:59:22 INFO - 'tabpaint']}, 05:59:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:59:22 INFO - 'ts_paint', 05:59:22 INFO - 'tpaint', 05:59:22 INFO - 'sessionrestore', 05:59:22 INFO - 'sessionrestore_no_auto_restore', 05:59:22 INFO - 'tabpaint']}, 05:59:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['a11yr', 05:59:22 INFO - 'ts_paint', 05:59:22 INFO - 'tpaint', 05:59:22 INFO - 'sessionrestore', 05:59:22 INFO - 'sessionrestore_no_auto_restore', 05:59:22 INFO - 'tabpaint']}, 05:59:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['a11yr', 05:59:22 INFO - 'ts_paint', 05:59:22 INFO - 'tpaint', 05:59:22 INFO - 'sessionrestore', 05:59:22 INFO - 'sessionrestore_no_auto_restore', 05:59:22 INFO - 'tabpaint']}, 05:59:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:59:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:59:22 INFO - 'bloom_basic_ref']}, 05:59:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['tsvgx', 05:59:22 INFO - 'tsvgr_opacity', 05:59:22 INFO - 'tart', 05:59:22 INFO - 'tscrollx', 05:59:22 INFO - 'cart', 05:59:22 INFO - 'tsvg_static']}, 05:59:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:59:22 INFO - 'tsvgr_opacity', 05:59:22 INFO - 'tart', 05:59:22 INFO - 'tscrollx', 05:59:22 INFO - 'cart', 05:59:22 INFO - 'tsvg_static']}, 05:59:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'talos_options': ['--disable-e10s'], 05:59:22 INFO - 'tests': ['tp5o']}, 05:59:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:59:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'talos_options': ['--disable-e10s', 05:59:22 INFO - '--xperf_path', 05:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:22 INFO - 'tests': ['tp5n']}, 05:59:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:59:22 INFO - 'talos_options': ['--xperf_path', 05:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:22 INFO - 'tests': ['tp5n']}}, 05:59:22 INFO - 'talos.zip': {'path': '', 05:59:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:22 INFO - Running post-action listener: _resource_record_post_action 05:59:22 INFO - [mozharness: 2017-05-25 12:59:22.806638Z] Finished populate-webroot step (success) 05:59:22 INFO - [mozharness: 2017-05-25 12:59:22.806726Z] Running create-virtualenv step. 05:59:22 INFO - Running pre-action listener: _resource_record_pre_action 05:59:22 INFO - Running main action method: create_virtualenv 05:59:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:22 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 05:59:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:22 INFO - Using real prefix '/usr' 05:59:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:25 INFO - Installing pip.................done. 05:59:25 INFO - Return code: 0 05:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:59:25 INFO - Reading from file tmpfile_stdout 05:59:25 INFO - Output received: 05:59:25 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) 05:59:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59:25 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')]} 05:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:25 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')]} 05:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:25 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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:25 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 05:59:25 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 05:59:25 INFO - Using env: {'DISPLAY': ':0', 05:59:25 INFO - 'HOME': '/home/cltbld', 05:59:25 INFO - 'LANG': 'en_US.UTF-8', 05:59:25 INFO - 'LANGUAGE': 'en_US:en', 05:59:25 INFO - 'LOGNAME': 'cltbld', 05:59:25 INFO - 'MAIL': '/var/mail/cltbld', 05:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:25 INFO - 'MOZ_NO_REMOTE': '1', 05:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:25 INFO - 'NO_EM_RESTART': '1', 05:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:25 INFO - 'PWD': '/builds/slave/test', 05:59:25 INFO - 'SHELL': '/bin/bash', 05:59:25 INFO - 'SHLVL': '1', 05:59:25 INFO - 'TERM': 'linux', 05:59:25 INFO - 'TMOUT': '86400', 05:59:25 INFO - 'USER': 'cltbld', 05:59:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:25 INFO - '_': '/tools/buildbot/bin/python'} 05:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:25 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 05:59:25 INFO - Cleaning up... 05:59:25 INFO - Return code: 0 05:59:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:59:25 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')]} 05:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:25 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')]} 05:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:25 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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:25 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 05:59:25 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 05:59:25 INFO - Using env: {'DISPLAY': ':0', 05:59:25 INFO - 'HOME': '/home/cltbld', 05:59:25 INFO - 'LANG': 'en_US.UTF-8', 05:59:25 INFO - 'LANGUAGE': 'en_US:en', 05:59:25 INFO - 'LOGNAME': 'cltbld', 05:59:25 INFO - 'MAIL': '/var/mail/cltbld', 05:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:25 INFO - 'MOZ_NO_REMOTE': '1', 05:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:25 INFO - 'NO_EM_RESTART': '1', 05:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:25 INFO - 'PWD': '/builds/slave/test', 05:59:25 INFO - 'SHELL': '/bin/bash', 05:59:25 INFO - 'SHLVL': '1', 05:59:25 INFO - 'TERM': 'linux', 05:59:25 INFO - 'TMOUT': '86400', 05:59:25 INFO - 'USER': 'cltbld', 05:59:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:25 INFO - '_': '/tools/buildbot/bin/python'} 05:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:26 INFO - Downloading/unpacking psutil>=3.1.1 05:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:27 INFO - Installing collected packages: psutil 05:59:27 INFO - Running setup.py install for psutil 05:59:27 INFO - building 'psutil._psutil_linux' extension 05:59:27 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 05:59:27 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 05:59:27 INFO - building 'psutil._psutil_posix' extension 05:59:27 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 05:59:27 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 05:59:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:27 INFO - Successfully installed psutil 05:59:27 INFO - Cleaning up... 05:59:27 INFO - Return code: 0 05:59:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59: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')]} 05:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:59:27 INFO - Using env: {'DISPLAY': ':0', 05:59:27 INFO - 'HOME': '/home/cltbld', 05:59:27 INFO - 'LANG': 'en_US.UTF-8', 05:59:27 INFO - 'LANGUAGE': 'en_US:en', 05:59:27 INFO - 'LOGNAME': 'cltbld', 05:59:27 INFO - 'MAIL': '/var/mail/cltbld', 05:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:27 INFO - 'MOZ_NO_REMOTE': '1', 05:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:27 INFO - 'NO_EM_RESTART': '1', 05:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:27 INFO - 'PWD': '/builds/slave/test', 05:59:27 INFO - 'SHELL': '/bin/bash', 05:59:27 INFO - 'SHLVL': '1', 05:59:27 INFO - 'TERM': 'linux', 05:59:27 INFO - 'TMOUT': '86400', 05:59:27 INFO - 'USER': 'cltbld', 05:59:27 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:27 INFO - '_': '/tools/buildbot/bin/python'} 05:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:59:28 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 05:59:28 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 05:59:28 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 05:59:28 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 05:59:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:59:29 INFO - Installing collected packages: mozsystemmonitor 05:59:29 INFO - Running setup.py install for mozsystemmonitor 05:59:29 INFO - Successfully installed mozsystemmonitor 05:59:29 INFO - Cleaning up... 05:59:29 INFO - Return code: 0 05:59:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:59:29 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')]} 05:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:29 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')]} 05:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:29 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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:29 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 05:59:29 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 05:59:29 INFO - Using env: {'DISPLAY': ':0', 05:59:29 INFO - 'HOME': '/home/cltbld', 05:59:29 INFO - 'LANG': 'en_US.UTF-8', 05:59:29 INFO - 'LANGUAGE': 'en_US:en', 05:59:29 INFO - 'LOGNAME': 'cltbld', 05:59:29 INFO - 'MAIL': '/var/mail/cltbld', 05:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:29 INFO - 'MOZ_NO_REMOTE': '1', 05:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:29 INFO - 'NO_EM_RESTART': '1', 05:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:29 INFO - 'PWD': '/builds/slave/test', 05:59:29 INFO - 'SHELL': '/bin/bash', 05:59:29 INFO - 'SHLVL': '1', 05:59:29 INFO - 'TERM': 'linux', 05:59:29 INFO - 'TMOUT': '86400', 05:59:29 INFO - 'USER': 'cltbld', 05:59:29 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:29 INFO - '_': '/tools/buildbot/bin/python'} 05:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:29 INFO - Downloading/unpacking jsonschema==2.5.1 05:59:29 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 05:59:29 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 05:59:29 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 05:59:29 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 05:59:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:30 INFO - warning: no files found matching '*.txt' 05:59:30 INFO - no previously-included directories found matching 'build' 05:59:30 INFO - no previously-included directories found matching 'dist' 05:59:30 INFO - no previously-included directories found matching '.git*' 05:59:30 INFO - Installing collected packages: jsonschema, functools32 05:59:30 INFO - Running setup.py install for functools32 05:59:30 INFO - warning: no files found matching '*.txt' 05:59:30 INFO - no previously-included directories found matching 'build' 05:59:30 INFO - no previously-included directories found matching 'dist' 05:59:30 INFO - no previously-included directories found matching '.git*' 05:59:30 INFO - Successfully installed jsonschema functools32 05:59:30 INFO - Cleaning up... 05:59:30 INFO - Return code: 0 05:59:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:30 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 05:59:30 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 05:59:30 INFO - Using env: {'DISPLAY': ':0', 05:59:30 INFO - 'HOME': '/home/cltbld', 05:59:30 INFO - 'LANG': 'en_US.UTF-8', 05:59:30 INFO - 'LANGUAGE': 'en_US:en', 05:59:30 INFO - 'LOGNAME': 'cltbld', 05:59:30 INFO - 'MAIL': '/var/mail/cltbld', 05:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:30 INFO - 'MOZ_NO_REMOTE': '1', 05:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:30 INFO - 'NO_EM_RESTART': '1', 05:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:30 INFO - 'PWD': '/builds/slave/test', 05:59:30 INFO - 'SHELL': '/bin/bash', 05:59:30 INFO - 'SHLVL': '1', 05:59:30 INFO - 'TERM': 'linux', 05:59:30 INFO - 'TMOUT': '86400', 05:59:30 INFO - 'USER': 'cltbld', 05:59:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:30 INFO - '_': '/tools/buildbot/bin/python'} 05:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:59:31 INFO - Cleaning up... 05:59:31 INFO - Return code: 0 05:59:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59: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')]} 05:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59: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', '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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:59: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 blobuploader==1.2.4 05:59:31 INFO - Using env: {'DISPLAY': ':0', 05:59:31 INFO - 'HOME': '/home/cltbld', 05:59:31 INFO - 'LANG': 'en_US.UTF-8', 05:59:31 INFO - 'LANGUAGE': 'en_US:en', 05:59:31 INFO - 'LOGNAME': 'cltbld', 05:59:31 INFO - 'MAIL': '/var/mail/cltbld', 05:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:31 INFO - 'MOZ_NO_REMOTE': '1', 05:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:31 INFO - 'NO_EM_RESTART': '1', 05:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:31 INFO - 'PWD': '/builds/slave/test', 05:59:31 INFO - 'SHELL': '/bin/bash', 05:59:31 INFO - 'SHLVL': '1', 05:59:31 INFO - 'TERM': 'linux', 05:59:31 INFO - 'TMOUT': '86400', 05:59:31 INFO - 'USER': 'cltbld', 05:59:31 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:31 INFO - '_': '/tools/buildbot/bin/python'} 05:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:59: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 05:59: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 05:59: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 05:59: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 05:59:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:32 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 05:59:32 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 05:59:32 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 05:59:32 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 05:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:32 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 05:59:32 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 05:59:32 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 05:59:32 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 05:59:33 INFO - Downloading docopt-0.6.1.tar.gz 05:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:33 INFO - Running setup.py install for blobuploader 05:59:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:33 INFO - Running setup.py install for requests 05:59:33 INFO - Running setup.py install for docopt 05:59:33 INFO - Successfully installed blobuploader requests docopt 05:59:33 INFO - Cleaning up... 05:59:33 INFO - Return code: 0 05:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:33 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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:33 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 05:59:33 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 05:59:33 INFO - Using env: {'DISPLAY': ':0', 05:59:33 INFO - 'HOME': '/home/cltbld', 05:59:33 INFO - 'LANG': 'en_US.UTF-8', 05:59:33 INFO - 'LANGUAGE': 'en_US:en', 05:59:33 INFO - 'LOGNAME': 'cltbld', 05:59:33 INFO - 'MAIL': '/var/mail/cltbld', 05:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:33 INFO - 'MOZ_NO_REMOTE': '1', 05:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:33 INFO - 'NO_EM_RESTART': '1', 05:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:33 INFO - 'PWD': '/builds/slave/test', 05:59:33 INFO - 'SHELL': '/bin/bash', 05:59:33 INFO - 'SHLVL': '1', 05:59:33 INFO - 'TERM': 'linux', 05:59:33 INFO - 'TMOUT': '86400', 05:59:33 INFO - 'USER': 'cltbld', 05:59:33 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:33 INFO - '_': '/tools/buildbot/bin/python'} 05:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:33 INFO - Running setup.py (path:/tmp/pip-S5b1sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:34 INFO - Running setup.py (path:/tmp/pip-xyAB0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:34 INFO - Running setup.py (path:/tmp/pip-U04Y6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:34 INFO - Running setup.py (path:/tmp/pip-wTktQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:34 INFO - Running setup.py (path:/tmp/pip-B689QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:34 INFO - Running setup.py (path:/tmp/pip-F3BLhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:34 INFO - Running setup.py (path:/tmp/pip-ebHfm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:34 INFO - Running setup.py (path:/tmp/pip-WCxY6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:34 INFO - Running setup.py (path:/tmp/pip-_GoARd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:34 INFO - Running setup.py (path:/tmp/pip-GHTIJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:34 INFO - Running setup.py (path:/tmp/pip-ZpcE7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:34 INFO - Running setup.py (path:/tmp/pip-xuHtfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:34 INFO - Running setup.py (path:/tmp/pip-hCxkHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:34 INFO - Running setup.py (path:/tmp/pip-wDa1Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:34 INFO - Running setup.py (path:/tmp/pip-bxVvyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:35 INFO - Running setup.py (path:/tmp/pip-ny00s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:35 INFO - Running setup.py (path:/tmp/pip-9zDPOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:35 INFO - Running setup.py install for manifestparser 05:59:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Running setup.py install for mozcrash 05:59:35 INFO - Running setup.py install for mozdebug 05:59:35 INFO - Running setup.py install for mozdevice 05:59:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Running setup.py install for mozfile 05:59:35 INFO - Running setup.py install for mozhttpd 05:59:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Running setup.py install for mozinfo 05:59:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Running setup.py install for mozInstall 05:59:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:35 INFO - Running setup.py install for mozleak 05:59:36 INFO - Running setup.py install for mozlog 05:59:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:36 INFO - Running setup.py install for moznetwork 05:59:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:36 INFO - Running setup.py install for mozprocess 05:59:36 INFO - Running setup.py install for mozprofile 05:59:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:36 INFO - Running setup.py install for mozrunner 05:59:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:36 INFO - Running setup.py install for mozscreenshot 05:59:36 INFO - Running setup.py install for moztest 05:59:36 INFO - Running setup.py install for mozversion 05:59:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:36 INFO - Cleaning up... 05:59:36 INFO - Return code: 0 05:59:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:36 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')]} 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:36 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')]} 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:36 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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:36 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 05:59:36 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 05:59:36 INFO - Using env: {'DISPLAY': ':0', 05:59:36 INFO - 'HOME': '/home/cltbld', 05:59:36 INFO - 'LANG': 'en_US.UTF-8', 05:59:36 INFO - 'LANGUAGE': 'en_US:en', 05:59:36 INFO - 'LOGNAME': 'cltbld', 05:59:36 INFO - 'MAIL': '/var/mail/cltbld', 05:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:36 INFO - 'MOZ_NO_REMOTE': '1', 05:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:36 INFO - 'NO_EM_RESTART': '1', 05:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:36 INFO - 'PWD': '/builds/slave/test', 05:59:36 INFO - 'SHELL': '/bin/bash', 05:59:36 INFO - 'SHLVL': '1', 05:59:36 INFO - 'TERM': 'linux', 05:59:36 INFO - 'TMOUT': '86400', 05:59:36 INFO - 'USER': 'cltbld', 05:59:36 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:36 INFO - '_': '/tools/buildbot/bin/python'} 05:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:37 INFO - Running setup.py (path:/tmp/pip-gpp4hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:37 INFO - Running setup.py (path:/tmp/pip-UDlHWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:37 INFO - Running setup.py (path:/tmp/pip-Iom4VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:37 INFO - Running setup.py (path:/tmp/pip-JNOywQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:37 INFO - Running setup.py (path:/tmp/pip-imgplp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:37 INFO - Running setup.py (path:/tmp/pip-LjHUem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:37 INFO - Running setup.py (path:/tmp/pip-ylgpLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:37 INFO - Running setup.py (path:/tmp/pip-UbmO0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:37 INFO - Running setup.py (path:/tmp/pip-z8SJjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:37 INFO - Running setup.py (path:/tmp/pip-mC0VjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:37 INFO - Running setup.py (path:/tmp/pip-H4BViO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:37 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)) 05:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:37 INFO - Running setup.py (path:/tmp/pip-Vd6GUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:38 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)) 05:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:38 INFO - Running setup.py (path:/tmp/pip-r25uwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:38 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)) 05:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:38 INFO - Running setup.py (path:/tmp/pip-T_OHbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:38 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)) 05:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:38 INFO - Running setup.py (path:/tmp/pip-A71v4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:38 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)) 05:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:38 INFO - Running setup.py (path:/tmp/pip-gGgun7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:38 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)) 05:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:38 INFO - Running setup.py (path:/tmp/pip-Vv_hgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:38 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)) 05:59:38 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)) 05:59:38 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)) 05:59:38 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)) 05:59:38 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)) 05:59:38 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)) 05:59:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59: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 05:59: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 05:59: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 05:59: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 05:59:39 INFO - Downloading blessings-1.6.tar.gz 05:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:39 INFO - Installing collected packages: blessings 05:59:39 INFO - Running setup.py install for blessings 05:59:39 INFO - Successfully installed blessings 05:59:39 INFO - Cleaning up... 05:59:39 INFO - Return code: 0 05:59:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:39 INFO - Reading from file tmpfile_stdout 05:59:39 INFO - Current package versions: 05:59:39 INFO - argparse == 1.2.1 05:59:39 INFO - blessings == 1.6 05:59:39 INFO - blobuploader == 1.2.4 05:59:39 INFO - docopt == 0.6.1 05:59:39 INFO - functools32 == 3.2.3-2 05:59:39 INFO - jsonschema == 2.5.1 05:59:39 INFO - manifestparser == 1.1 05:59:39 INFO - mozInstall == 1.12 05:59:39 INFO - mozcrash == 1.0 05:59:39 INFO - mozdebug == 0.1 05:59:39 INFO - mozdevice == 0.51 05:59:39 INFO - mozfile == 1.2 05:59:39 INFO - mozhttpd == 0.7 05:59:39 INFO - mozinfo == 0.9 05:59:39 INFO - mozleak == 0.1 05:59:39 INFO - mozlog == 3.4 05:59:39 INFO - moznetwork == 0.27 05:59:39 INFO - mozprocess == 0.25 05:59:39 INFO - mozprofile == 0.28 05:59:39 INFO - mozrunner == 6.13 05:59:39 INFO - mozscreenshot == 0.1 05:59:39 INFO - mozsystemmonitor == 0.3 05:59:39 INFO - moztest == 0.8 05:59:39 INFO - mozversion == 1.4 05:59:39 INFO - psutil == 3.1.1 05:59:39 INFO - requests == 1.2.3 05:59:39 INFO - wsgiref == 0.1.2 05:59:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:39 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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:39 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 05:59:39 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 05:59:39 INFO - Using env: {'DISPLAY': ':0', 05:59:39 INFO - 'HOME': '/home/cltbld', 05:59:39 INFO - 'LANG': 'en_US.UTF-8', 05:59:39 INFO - 'LANGUAGE': 'en_US:en', 05:59:39 INFO - 'LOGNAME': 'cltbld', 05:59:39 INFO - 'MAIL': '/var/mail/cltbld', 05:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:39 INFO - 'MOZ_NO_REMOTE': '1', 05:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:39 INFO - 'NO_EM_RESTART': '1', 05:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:39 INFO - 'PWD': '/builds/slave/test', 05:59:39 INFO - 'SHELL': '/bin/bash', 05:59:39 INFO - 'SHLVL': '1', 05:59:39 INFO - 'TERM': 'linux', 05:59:39 INFO - 'TMOUT': '86400', 05:59:39 INFO - 'USER': 'cltbld', 05:59:39 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:39 INFO - '_': '/tools/buildbot/bin/python'} 05:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:40 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)) 05:59:40 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)) 05:59:40 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)) 05:59:40 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)) 05:59:40 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)) 05:59:40 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)) 05:59:40 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)) 05:59:40 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)) 05:59:40 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)) 05:59:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:59:40 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 05:59:40 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 05:59:40 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 05:59:40 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 05:59:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:59:41 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)) 05:59:41 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)) 05:59:41 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)) 05:59:41 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)) 05:59:41 INFO - Installing collected packages: marionette-driver 05:59:41 INFO - Running setup.py install for marionette-driver 05:59:41 INFO - Successfully installed marionette-driver 05:59:41 INFO - Cleaning up... 05:59:41 INFO - Return code: 0 05:59:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:41 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')]} 05:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:41 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')]} 05:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:41 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 0xc571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe24a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfca5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', '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 05:59:41 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 05:59:41 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 05:59:41 INFO - Using env: {'DISPLAY': ':0', 05:59:41 INFO - 'HOME': '/home/cltbld', 05:59:41 INFO - 'LANG': 'en_US.UTF-8', 05:59:41 INFO - 'LANGUAGE': 'en_US:en', 05:59:41 INFO - 'LOGNAME': 'cltbld', 05:59:41 INFO - 'MAIL': '/var/mail/cltbld', 05:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:41 INFO - 'MOZ_NO_REMOTE': '1', 05:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:41 INFO - 'NO_EM_RESTART': '1', 05:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:41 INFO - 'PWD': '/builds/slave/test', 05:59:41 INFO - 'SHELL': '/bin/bash', 05:59:41 INFO - 'SHLVL': '1', 05:59:41 INFO - 'TERM': 'linux', 05:59:41 INFO - 'TMOUT': '86400', 05:59:41 INFO - 'USER': 'cltbld', 05:59:41 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:41 INFO - '_': '/tools/buildbot/bin/python'} 05:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:59:41 INFO - Cleaning up... 05:59:41 INFO - Return code: 0 05:59:41 INFO - Running post-action listener: _resource_record_post_action 05:59:41 INFO - Running post-action listener: _start_resource_monitoring 05:59:41 INFO - Starting resource monitoring. 05:59:41 INFO - [mozharness: 2017-05-25 12:59:41.774225Z] Finished create-virtualenv step (success) 05:59:41 INFO - [mozharness: 2017-05-25 12:59:41.774734Z] Running install step. 05:59:41 INFO - Running pre-action listener: _resource_record_pre_action 05:59:41 INFO - Running main action method: install 05:59:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:41 INFO - Reading from file tmpfile_stdout 05:59:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:42 INFO - Reading from file tmpfile_stdout 05:59:42 INFO - Output received: 05:59:42 INFO - Usage: mozinstall [options] installer 05:59:42 INFO - Options: 05:59:42 INFO - -h, --help show this help message and exit 05:59:42 INFO - -d DEST, --destination=DEST 05:59:42 INFO - Directory to install application into. [default: 05:59:42 INFO - "/builds/slave/test"] 05:59:42 INFO - --app=APP Application being installed. [default: firefox] 05:59:42 INFO - mkdir: /builds/slave/test/build/application 05:59:42 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'] 05:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:59:58 INFO - Reading from file tmpfile_stdout 05:59:58 INFO - Output received: 05:59:58 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:58 INFO - Running post-action listener: _resource_record_post_action 05:59:58 INFO - [mozharness: 2017-05-25 12:59:58.404276Z] Finished install step (success) 05:59:58 INFO - [mozharness: 2017-05-25 12:59:58.404548Z] Running run-tests step. 05:59:58 INFO - Running pre-action listener: _resource_record_pre_action 05:59:58 INFO - Running main action method: run_tests 05:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:58 INFO - Python 2.7.3 05:59:58 INFO - Return code: 0 05:59:58 INFO - grabbing minidump binary from tooltool 05:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:58 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 0xfc77a0>, '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 0xfc86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc8b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:58 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 05:59:58 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 05:59:58 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 05:59:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:58 INFO - Return code: 0 05:59:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:58 INFO - ENV: RUST_BACKTRACE is now 1 05:59:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:58 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/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 05:59:58 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/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 05:59:58 INFO - Using env: {'DISPLAY': ':0', 05:59:58 INFO - 'HOME': '/home/cltbld', 05:59:58 INFO - 'LANG': 'en_US.UTF-8', 05:59:58 INFO - 'LANGUAGE': 'en_US:en', 05:59:58 INFO - 'LOGNAME': 'cltbld', 05:59:58 INFO - 'MAIL': '/var/mail/cltbld', 05:59:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:58 INFO - 'MOZ_NO_REMOTE': '1', 05:59:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:58 INFO - 'NO_EM_RESTART': '1', 05:59:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:58 INFO - 'PWD': '/builds/slave/test', 05:59:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:58 INFO - 'RUST_BACKTRACE': '1', 05:59:58 INFO - 'SHELL': '/bin/bash', 05:59:58 INFO - 'SHLVL': '1', 05:59:58 INFO - 'TERM': 'linux', 05:59:58 INFO - 'TMOUT': '86400', 05:59:58 INFO - 'USER': 'cltbld', 05:59:58 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927', 05:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:58 INFO - '_': '/tools/buildbot/bin/python'} 05:59:58 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/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 05:59:58 INFO - mozversion application_buildid: 20170525122402 05:59:58 INFO - mozversion application_changeset: e8da7192201e5786614ec49d557e64dffd114ff2 05:59:58 INFO - mozversion application_display_name: Nightly 05:59:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:58 INFO - mozversion application_name: Firefox 05:59:58 INFO - mozversion application_remotingname: firefox 05:59:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:59:58 INFO - mozversion application_vendor: Mozilla 05:59:58 INFO - mozversion application_version: 55.0a1 05:59:58 INFO - mozversion platform_buildid: 20170525122402 05:59:58 INFO - mozversion platform_changeset: e8da7192201e5786614ec49d557e64dffd114ff2 05:59:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:59:58 INFO - mozversion platform_version: 55.0a1 05:59:58 INFO - using testdate: 1495717198 05:59:58 INFO - actual date: 1495717198 05:59:58 INFO - starting webserver on 'localhost:50770' 05:59:58 INFO - SUITE-START | Running 2 tests 05:59:58 INFO - TEST-START | dromaeo_css 05:59:58 INFO - operating with platform_type : linux_ 05:59:58 INFO - Initialising browser for dromaeo_css test... 05:59:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50770/getInfo.html -profile /tmp/tmp6iGq3N/profile 05:59:58 INFO - TEST-INFO | started process 25348 (/builds/slave/test/build/application/firefox/firefox http://localhost:50770/getInfo.html) 06:00:33 INFO - TEST-INFO | 25348: killed by SIGTERM 06:00:34 INFO - Browser initialized. 06:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:00:34 INFO - TEST-INFO | started process 25547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6iGq3N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:46 INFO - PID 25547 | RSS: Main: 172421120 06:00:46 INFO - PID 25547 | 06:03:50 INFO - PID 25547 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50770/tests/dromaeo/cssquery-ext.html) 06:03:52 INFO - PID 25547 | RSS: Main: 170573824 06:03:52 INFO - PID 25547 | 06:06:54 INFO - PID 25547 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-ext.html (next: http://localhost:50770/tests/dromaeo/cssquery-jquery.html) 06:06:54 INFO - PID 25547 | RSS: Main: 175607808 06:06:54 INFO - PID 25547 | 06:09:56 INFO - PID 25547 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50770/tests/dromaeo/cssquery-mootools.html) 06:09:56 INFO - PID 25547 | RSS: Main: 176218112 06:09:56 INFO - PID 25547 | 06:12:58 INFO - PID 25547 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50770/tests/dromaeo/cssquery-prototype.html) 06:12:59 INFO - PID 25547 | RSS: Main: 178499584 06:12:59 INFO - PID 25547 | 06:16:01 INFO - PID 25547 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50770/tests/dromaeo/cssquery-yui.html) 06:16:02 INFO - PID 25547 | RSS: Main: 177139712 06:16:02 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-yui.html (next: http://localhost:50770/tests/dromaeo/cssquery-dojo.html) 06:19:04 INFO - PID 25547 | RSS: Main: 174551040 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | __start_tp_report 06:19:04 INFO - PID 25547 | _x_x_mozilla_page_load 06:19:04 INFO - PID 25547 | _x_x_mozilla_page_load_details 06:19:04 INFO - PID 25547 | |i|pagename|runs| 06:19:04 INFO - PID 25547 | |0;dojo.html;2694.717054709255;2718.0622685173607;2726.6182734417184;2742.506348857205;2747.848868312242;5142.562882155022;5241.08281050816;5247.921281180786;5279.076161671711;5297.682139071653;5157.5616072633775;5163.096458119833;5188.351456067991;5269.947300527003;5270.446603106676;4590.954090459103;4641.628669706432;4690.0854333405;4707.976460117712;4717.858464246078;4553.27147656375;4641.535846415365;4685.83599574015;4718.9292160617615;4730.668853180278;4585.885352866172;4671.182543054952;4672.836450724209;4740.07568524138;4787.281907713836;4608.423947006624;4621.399218101626;4655.557722016403;4698.107359601665;4701.106789709944;4654.25531914892;4664.323673067386;4666.953330466686;4687.484376718558;4698.8355407560575;5186.948130518685;5227.372715274191;5240.4497527759795;5248.134057880445;5261.921071183935;5545.112781954868;5626.2967129108865;5627.212190293321;5661.575381846378;5713.114467257582;5686.772529098873;5797.420257974211;5804.1293805929445;5807.186993820868;5819.67991760453;5296.09966305729;5299.6025298102795;5299.682019078868;5301.284326615858;5305.867353316198;5802.003641175134;5805.071188609802;5818.156367326714;5830.4461076197695;5846.269216347957;5480.698561579072;5573.526250268773;5608.327000759935;5650.4349565043985;5655.462731040545;5628.549716022709;5659.971700141473;5664.461876121762;5676.460736230134;5721.427857214246;5514.365847927459;5632.986062508788;5633.408492108351;5634.774609015675;5654.97172514143;5568.192612071227;5635.267415236075;5635.492805647429;5667.4332566743;5671.943280567224;4708.387909571802;4711.646626503026;4719;4738;4759.833405830779;4050.7569545827346;4060.5939406059156;4101.282275601758;4104.076582768913;4123.670106391482;4731.550502702238;4784.378030856036;4805.231163013901;4805.951940480621;4836;5442.809501667422;5477.123660214346;5507.03626865297;5528.530074943675;5638.577106717013;4831.371921650163;4832;4840.878978025507;4856.562909338177;4877.341558889575;5005.274235235943;5018.096742586369;5030.622703297194;5063.5695965843315;5064.746762661852;5183.352080989876;5193.298904647824;5260.842174734764;5271.894562108813;5283.630145889751;5747.48272655463;5747.97126014384;5756.625819321731;5772.9711351442975;5805.593608447537;5233.581313494835;5251.632385732962;5314.3091398117995;5326.467353264643;5357.78568857257;5492.69790161529;5599.748011339418;5609.943900560942;5628.296462942132;5646.88706225865;5646.435356464321;5713.771449141987;5737.483626473638;5750.654960702204;5754.395788442321;5424.83725488236;5479.2602998594675;5488.506034456918;5509.173623956439;5550.777968881361;5559.58303127259;5567.860803479945;5569.777208911761;5570.526505246938;5571.192177134374;5333.359996800409;5350.250964864844;5493.917591236055;5514.862128446661;5550.5282051026115;5493.121100623881;5574.749136288796;5576.609637325349;5577.553795696415;5585.218069470358;5416.133418652997;5416.83749487516;5423.83728488146;5431.646942948696;5454.154606036071 06:19:04 INFO - PID 25547 | |1;ext.html;657.1358663357685;700.3276854219948;726.5931078595987;1047.099494434786;1076.2358725305032;33141.33717325655;33711.15722106949;33961.83019084901;34128.146796330104;34134.14664633385;35425.46861797075;35489.467657985086;35711.821440892825;35858.8207058965;35993.46009809855;6462.772073306057;6648.833779155536;6883.724651013966;7014.789556313293;7018.9298107018785;6530.379613936669;6621;6629.204495460527;6632.734690612369;6636.236832764245;6612.404883560479;6618.106555614979;6667.466602671775;6674.499412544054;6686.197656281229;6546.607203567801;6576.572522786051;6586.242582103072;6631.336866313378;6642.767503137416;6547.672616369163;6562.868742625121;6598.076269322299;6615.106960560311;6618.867622647568;32090;32178;32206.838965805255;32212.35575288481;32375.514367284508;3052.0996306089755;3085.059056987618;3088.382323535302;3098.9690103098906;3104.472239719253;24421.755782442127;24458.388540286458;24527.632085518733;24599.508009839883;24642.630360544605;2591.20968104728;2683.235277945776;2701.162639581736;2720.91837244883;2737.8083534152615;141899;142119;142289;150428;154142;39728;39829.402558961636;39984.400233996515;40085.79957100196;40132.398014029815;41835.58164418317;41835.581644183774;41853;41858.1628367431;44760;11868;11951.402429878472;11957.52169913211;11967.820482692767;12056.457459414347;9425.340226184238;9445.811083778424;9472.810543789223;9485.336026478219;9488.620455181854;12948.870511294956;12998.740025199442;13016.15394999322;13094.011478290242;13170.407331669907;5427.6200665953;5428.348598168166;5510.393856675762;5591.273134492571;5667.044869520009;861.1001503428931;886.9157430044136;924.3252425729121;928.7028150991617;943.4763706143157;20333.763286038524;20779.58440831205;21286;21365.46586335354;21780;984.3650845204803;992.6575331510618;1000.8048430556117;1002.6490728245055;1025.123519390925;10639.521221544894;10992.450377481255;11274.830877536844;11321.886781132249;11391.943040284745;170625;170814;171053;171571;172070;40930.38604420936;41407.792961035004;41565.376519352234;41659.37510937338;41745;1178.5168081086713;1238.7055526974334;1244.8381710377594;1252.4489224741085;1256.0767835640797;19232.61534769269;19865.205391784166;20747.27384541594;20776.79223207809;21044.368668939955;29878.402431951676;37684.811575941945;38141;38484.615153848106;38585.80707096559;158953.2052339731;161784;161873;162004.18997904935;162077;30073.24816879508;30239.848800755855;30257.848710756305;30537.54193687052;30595.847020764755;35739.49823512433;35799.46300805542;36004.09989750277;36046.81976590205;36243.63756362403;27469.587956181073;27630;27796;27829.582556261266;28666.570001449578;25979.74020259773;26803.19590412291;27470.862645686644;27515.86242068777;28595.714042859305;29781.10656680303;30162.69837301687;30684;30906.845465772527;30961.380772383975;26195.869020654776;26664.866675666497;26739.197824065308;26944.865275673495;27794.722052780024;19722;22065.889670551544;22232;22297.554048918606;22683.319500415015 06:19:04 INFO - PID 25547 | |2;jquery.html;401.80110845131645;406.27074401449397;414.43015853201837;418.6922611880268;427.9935800962984;17025.14874256287;17410.216540255686;17664.558386040357;17718;18375.90812045941;18889.62220755584;18938.337158199465;19091.61816763664;19128.521786955298;19299.614007719836;5348.411674715778;5414.512693857552;5629.9437005629825;5634.7182640867795;5643.774249030034;5234.973825130869;5300.973495132519;5331.067063263913;5331.2003199519995;5352.625316227865;5277.208418737201;5295.443978382272;5309.469053094698;5318.893622127574;5328.520433161015;5141.434442211354;5310.575153987672;5334.11987022139;5355.0628639988045;5380.139177731544;4839.911020020502;4839.975800121012;4845.030993801219;4846.442659094178;4857.247126695368;21595.1361945522;21597.784022159736;21765.67351489713;21795.891020544797;22014.559708805893;1594.2825728422256;1628.071998960593;1639.7950256217973;1640.5078476457134;1643.1948345310711;13822;14062.859371406257;14170.787438188436;14208.92895535526;14384.28078596066;1917.9520511987173;1928.8264056234866;1965.263026365113;2002.8898410587412;2010.1155491583656;75065.24934750637;75598.62200689016;75870.24129758686;76884.61557692231;76927.23072769257;10837.729056773644;11078;11140.442977851075;11173.273737207055;11233.213675042669;15576.454824081104;15579.221038948008;15626.140562268956;15630.29663665115;15631.765523517157;7352.411807055422;7410.703571857065;7510.399168066541;7622.618869056636;7634.923650763532;6760;6770.763023294161;6844.794656160323;7005.299470053056;7011.439084873198;6682.264950855402;6684.331566843374;6944.270851560514;6944.618046007518;7062.364387205176;1974.6741787605172;2010.8894010829251;2034.9898250508652;2040.6234298591826;2070.254708305009;872.8952525696957;892.7187935800202;894.5303715549388;906.909309069101;934.0892629686002;16582.668346633;16627.584310392096;16891.662166756596;16905.49283521496;17540.122993850255;887.3566664168555;900.8603666431713;901.7204666553389;902.8329758994607;924.3390975452584;8981.820363592691;9515.762105947406;9605.567749451291;9711.223102151811;9730.270229732798;343276;345513;347388;356200;356640;72569.6371518139;72627;74962;75716.62141689257;75727;1038.2213339995003;1043.1915265669168;1066.1630619963446;1073.8442925775876;1079.875814281352;14187.574372768833;14436.350364233846;14499;14572.708545828811;15171.468998584996;35569.28861422705;37481.4377784328;38100;38368.2326353477;38471.422928656655;45926;46201.76899115483;47069.52930470651;47218.29172562483;48456;7394.2975417335265;7443.813904652427;7458.776236712907;7505.737299194502;7554.66004029809;11861.229020113666;11960.521579137085;12592.307423091817;12644.683882902633;12897.677558061123;9466.05339466048;10196.898031019595;10568.788624227318;10957.342559446459;11051.281666691639;9792.412455252708;10028.949855250678;10067.949660251945;10209.132223761064;10209.336393134423;10825.945870270598;11082.667519974413;11118.332900026024;11337.546498139982;11475.254108482923;7799.610019499116;7979.840403191787;8038.919610803817;8086.908267384063;8328.125546817497;10226.795464090825;10309.432981186106;10373.688789336333;10414.114800242065;10801.513931872927 06:19:04 INFO - PID 25547 | |3;mootools.html;1245.8629550749417;1291.1459294007386;1306.9803952940701;1311.1543054729696;1321.4383886848086;9785;10199.949000255006;10335.276530642857;10373.17014638829;10548.525316360763;9899.901000989988;10043.347182433137;10078.899211007887;10080.949595252032;10090.192784577235;2134.1036764558844;2170.6201414752436;2173.89130543473;2174.065151984646;2185.1259496201487;2104.221438067917;2144.04589957469;2145.903434345458;2155.051777218027;2155.622766015949;2038.551518665891;2091.811736943675;2097.83217342613;2105.894705264738;2110.778368271325;2021.6866385710239;2024.0992758222596;2034.3286715383888;2040.6530889748778;2043.1010355443557;1942.6118436019526;1975.0223639298495;2073.6060148571873;2147.3235930681785;2148.9355319340443;9686.273529485246;9898;9957.651482198089;9962.651307204213;9999.35004224723;5212.4266330703595;5384.273123128367;5391.757370918318;5402.486763757437;5416.350037995466;2987.671356150822;3017.5926249956196;3068.861901214451;3097.674744151877;3111.3466172103886;906.1436942089728;916.4684482999844;967.6081187119228;980.6224603527693;993.5181437003048;14101.224432656303;14430.855691443056;14433.92783036078;14461.855381446156;14472.999999999894;4810.6151507879285;4846.903061938741;4849.636277279147;4958.677685950402;4991.151504244287;12231;12249.816252756216;12254.264744115382;12259.570915017932;12296.631101066982;5501.697406642593;5606.719664016864;5607.4112218217315;5630.774769009194;5643.35101463337;4976.477469865612;5015.824446144367;5050.292958985745;5064.265681476239;5085.720285384339;4209.137126888981;4230.428892099589;4243.830246790094;4254.574542545721;4331.371951067141;1305.5887395470397;1322.9867701323055;1364.515596963064;1366.7881478370869;1375.2023826180991;715.345458905096;736.7900148457663;741.4809633256634;750.7597568777938;759.7910574592031;5724.914126288109;5825.03886858672;6535.771248006297;6635.86728265432;6811.931880681229;835.5404527509967;857.4812238595684;863.96976105836;865.8311629232239;868.2489646455897;3780.3573392523335;3969.4244334571326;3977.7414468059483;4109.198706252252;4139.97930010348;12188.268703877618;12724.427400766988;13109.803352949713;13135.868641313464;13136.34318284101;12729;12773.936130319289;12993.935030324788;13025.348732563334;13164.210147391188;7240.1311842579225;7362.779116626402;7366.263373662698;7375.151857536344;7383.2616738326815;5620.803271885465;5694.857628559319;5703.344115426779;5773.595848290747;5909.852253693692;11709.707257318294;11752.70618234551;11845.289282642725;11933.28400295985;11943.76112477763;11912.583059592873;11957.402129893297;11963.342016189194;12034.097442691658;12056.51773929033;7368.189499155196;7423.443241756998;7502.924970750222;7509.4367922404945;7538.924610754042;9440.763980900532;9494.098060684224;9529.666461673809;9546.522673866419;9576.281778866474;7978.197955810192;7984.842197881158;8035.558044307385;8079.959600201962;8162.551059691774;8025.07711613172;8037.879431808645;8039.799005024921;8185.672573097009;8294.626741796514;7258.274172582699;7282.927170728437;7291.744788932362;7304.342609164988;7344.779656610311;5354.143337066051;5377.27406800077;5485.890282194254;5490.670559766427;5591.888162236651;5353.437889021752;5389.326334208224;5439.728013599225;5494.670319780826;5642.7460764266525 06:19:04 INFO - PID 25547 | |4;prototype.html;335.33268795097763;348.43727380280825;349.6730556929271;356.9107723069231;358.17619475207016;5378.193271009351;5552.250446189763;5553.972230138854;5581.190727344538;5595.740958284384;5309.814156504523;5409.377921539024;5411.242426060355;5412.891742165154;5450.890982180354;4026.315526360526;4031.5565287818317;4047.736897101679;4051.9392209116886;4052.257529262416;3886.514185726784;4008.5590585035625;4053.1893621275717;4054.797260136996;4057.6753859691303;4012.8194231259663;4013.6187062229187;4021.939670904939;4029.758214507124;4029.919401611966;3946.9210615787524;3994.4008398740275;4001.639852413268;4011.97994010031;4013.7391069580385;3453.637368076341;3465.28961562879;3469.826508674556;3473.808940508271;3486.0936156599214;5276;5301.416844147141;5325.813596524142;5373;5381.7578208980685;4717.839047837922;4721.102990431841;4734.526547345273;4737.857864264078;4751.216049351853;5602.551795856321;5776.5089967352405;5782.45066718661;5789.478946894799;5790.334111577138;3880.4373365862075;3901.31726947783;3904.1606054698377;3910.081130934228;3911.413288006793;5844.386339434383;6047.546434017467;6077.513798896078;6114.571979961404;6154.692265386713;3943.8028098594955;3995.380715989026;3996.8800935971385;4005.35914253718;4010.8195131219163;4048.777317247521;4065.0650350418978;4065.715399921977;4066.7763273019677;4071.714979951375;4558.697857581966;4666.346711460398;4705.12955103307;4712.882177945578;4747.121782470254;5780.913286300709;5804.1293805929445;5818.185454036438;5834.824955251349;5858.912116318259;1390.7009992851383;1392.4291040673274;1392.7284179584883;1393.4983405973842;1393.6306878677158;873.2359185712502;909.7407238936871;925.5696101312922;927.4759760735163;927.8283517549276;5013.197888337849;5074.771635276422;5076.568491678175;5077.162268225775;5077.26379674945;5973.701314934236;5976.207137858712;5982.73077711504;5991.340952495222;6006.729697163638;4861.565838077776;4982.160168703804;5005.224190250517;5021.297018417425;5025.939364860463;3159.936801263962;3162.525621156845;3175.9039034237753;3184.4268031754505;3193.7803226757646;5438.721900353414;5545;5553.111502159635;5579.358373786985;5591.9720401397735;6059.969700151471;6079.787207447718;6155.969220153871;6161.507079433634;6215.689215539205;5563.749631266603;5566.972165139148;5580.804671836466;5592.832215033555;5599.608027438122;5675.772969081356;5926.7925622603;5978.282606087298;6047.5464340173785;6075.210222671025;5879.882402351844;5900.940990590211;5915.674637894957;5926.674032928058;5934.584579079596;5312.38907525624;5491.697956612425;5518.227448157181;5527.53015993645;5572.77708891656;3952.7628342299554;3957.22834047358;3971.980140099281;3976.7613943162346;3989.501312335958;5919.4968427684125;6016.308124565731;6025.487833534199;6030.276366835832;6032.90950635732;5762.135679648086;5782.860341673608;5814.912776308443;5815.680137592473;5839.926825976717;5768.826935191951;5807.593468457337;5824.94175058244;5836.270466191726;5842.591018628826;5665.150227465913;5698.857528561819;5736.447280959933;5752.0509115997065;5770.538356931519;5848.707564621837;5855.707214639337;5863.501602363847;5891.49922256613;5899.203607512931;5443.4284400138995;5631.380548139783;5655.4344565543115;5677.659340439587;5710.857228569319 06:19:04 INFO - PID 25547 | |5;yui.html;736.2196072163507;746.7610364683296;757.9421869623969;758.3288789421363;762.3101093510371;13508.594742157738;14615.634609134777;14633.560993170195;16286.267117979689;16739.246733897005;16619;16805.15974201291;16879.746803797952;16881.577960550963;16906.07016614089;873.8470767615642;903.8824952756149;907.0929070929071;913.2374467319796;914.1635403605693;905.5698543191965;914.8490499067645;917.2432742987029;918.2011649864627;918.9127032931895;957.3968399908048;958.7363475044349;962.4995002598645;963.9180669643089;964.6912987843892;949.3544389814923;951.2104952889085;951.9095685909828;952.8618350339232;953.537534295866;702.764573867755;703.022798310349;703.0824773670358;704.7462913351189;705.5272967112047;14377.856221437756;14448.638784030378;14872.033317834306;14881.776773348409;14994;16009.839901600952;16422.917885410498;16424.75362869558;16446.917765411217;16502.33990640373;11909.344986025764;12106.697332566668;12225.144239903211;12247.877521224851;12283.57007504733;2969.7178768017;3012.6535448423274;3018.3208778024987;3018.9698103019127;3020.365723198131;81786.18213817905;83825;84114;84137.73793393104;84641.15358846395;11409.828852567218;11431.942840285912;11559.76880462386;11616.186866919403;11698.532058717727;22498.437539061328;23109.19117830868;23144;23246.53506929852;23271.53456930852;5901.911471327933;5931.9406805931385;6054.364291749391;6095.3904609538695;6159.6612186330185;2950.867210975511;3025.667176610571;3032.3935212957495;3036.6356037275227;3038.270815004383;3314.867405303809;3381.7801842880626;3388.1360253135294;3392.525046493493;3400.931981360359;660.9140811694449;667.4060086522999;667.4760313154151;668.2982867988593;668.4418510543653;559.3120461831969;587.2424572301768;594.6848170469658;594.7888499582673;601.1433706967641;9147.0852914708;9654.951725241328;9884.950575247078;10356.844647330296;11071.944640276746;562.2578196780211;564.9463300986399;565.028151579283;574.5977815529146;575.4159528079003;4661.463931647904;4793.209120495149;4836.46798852126;4848.8302909398;4895.241237608177;89259;92804.53597731968;92827;93118.53440732753;93609.53195234116;70377.64811175912;70854;70961.64519177371;76931.61534192406;82208.58895705483;57420.42579574235;57589.424105759244;58452;58468.70765646145;59692;9740.756481087747;10470.947645261725;10557.78884422292;10814.351138931375;11027.83458248111;27634;27791.722082778913;27820.44359112766;29133.086691330696;29523;35321.823390882884;35435.82282088573;35603.64396356003;35699.82150089233;36252.63747362493;13707.520236791665;13771.242581658105;13952.511662091778;14038.649033774238;14210.502632407815;15759.13324767103;15823.920880395524;15991.360345586047;16229.59426014359;16527.50417487477;14030.158190508602;14048.2975851205;14366;14689.779653305422;14788.334524946187;14860;14942.477013304482;15129.39482420735;15156.696866062837;15425.228738563252;12541.372931353213;12650.936745316214;12741.49034038628;13042.413091410719;13153.802692959805;9500.857487137837;9508.144267016001;9595.856062159213;10365.84451233217;10593.947030264799;11495;11965.940170299093;12055.457504412498;12106.07492910081;12213.206141600767 06:19:04 INFO - PID 25547 | __end_tp_report 06:19:04 INFO - PID 25547 | __start_cc_report 06:19:04 INFO - PID 25547 | _x_x_mozilla_cycle_collect,345 06:19:04 INFO - PID 25547 | __end_cc_report 06:19:04 INFO - PID 25547 | __startTimestamp1495718344598__endTimestamp 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | ------- Summary: start ------- 06:19:04 INFO - PID 25547 | Number of tests: 6 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | [#0] dojo.html Cycles:165 Average:5180.20 Median:5314.31 stddev:613.14 (11.5%) stddev-sans-first:583.20 06:19:04 INFO - PID 25547 | Values: 2694.7 2718.1 2726.6 2742.5 2747.8 5142.6 5241.1 5247.9 5279.1 5297.7 5157.6 5163.1 5188.4 5269.9 5270.4 4591.0 4641.6 4690.1 4708.0 4717.9 4553.3 4641.5 4685.8 4718.9 4730.7 4585.9 4671.2 4672.8 4740.1 4787.3 4608.4 4621.4 4655.6 4698.1 4701.1 4654.3 4664.3 4667.0 4687.5 4698.8 5186.9 5227.4 5240.4 5248.1 5261.9 5545.1 5626.3 5627.2 5661.6 5713.1 5686.8 5797.4 5804.1 5807.2 5819.7 5296.1 5299.6 5299.7 5301.3 5305.9 5802.0 5805.1 5818.2 5830.4 5846.3 5480.7 5573.5 5608.3 5650.4 5655.5 5628.5 5660.0 5664.5 5676.5 5721.4 5514.4 5633.0 5633.4 5634.8 5655.0 5568.2 5635.3 5635.5 5667.4 5671.9 4708.4 4711.6 4719.0 4738.0 4759.8 4050.8 4060.6 4101.3 4104.1 4123.7 4731.6 4784.4 4805.2 4806.0 4836.0 5442.8 5477.1 5507.0 5528.5 5638.6 4831.4 4832.0 4840.9 4856.6 4877.3 5005.3 5018.1 5030.6 5063.6 5064.7 5183.4 5193.3 5260.8 5271.9 5283.6 5747.5 5748.0 5756.6 5773.0 5805.6 5233.6 5251.6 5314.3 5326.5 5357.8 5492.7 5599.7 5609.9 5628.3 5646.9 5646.4 5713.8 5737.5 5750.7 5754.4 5424.8 5479.3 5488.5 5509.2 5550.8 5559.6 5567.9 5569.8 5570.5 5571.2 5333.4 5350.3 5493.9 5514.9 5550.5 5493.1 5574.7 5576.6 5577.6 5585.2 5416.1 5416.8 5423.8 5431.6 5454.2 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | [#1] ext.html Cycles:180 Average:30599.69 Median:3086.72 stddev:41305.93 (1338.2%) stddev-sans-first:41360.62 06:19:04 INFO - PID 25547 | Values: 657.1 700.3 726.6 1047.1 1076.2 33141.3 33711.2 33961.8 34128.1 34134.1 35425.5 35489.5 35711.8 35858.8 35993.5 6462.8 6648.8 6883.7 7014.8 7018.9 6530.4 6621.0 6629.2 6632.7 6636.2 6612.4 6618.1 6667.5 6674.5 6686.2 6546.6 6576.6 6586.2 6631.3 6642.8 6547.7 6562.9 6598.1 6615.1 6618.9 32090.0 32178.0 32206.8 32212.4 32375.5 3052.1 3085.1 3088.4 3099.0 3104.5 24421.8 24458.4 24527.6 24599.5 24642.6 2591.2 2683.2 2701.2 2720.9 2737.8 141899.0 142119.0 142289.0 150428.0 154142.0 39728.0 39829.4 39984.4 40085.8 40132.4 41835.6 41835.6 41853.0 41858.2 44760.0 11868.0 11951.4 11957.5 11967.8 12056.5 9425.3 9445.8 9472.8 9485.3 9488.6 12948.9 12998.7 13016.2 13094.0 13170.4 5427.6 5428.3 5510.4 5591.3 5667.0 861.1 886.9 924.3 928.7 943.5 20333.8 20779.6 21286.0 21365.5 21780.0 984.4 992.7 1000.8 1002.6 1025.1 10639.5 10992.5 11274.8 11321.9 11391.9 170625.0 170814.0 171053.0 171571.0 172070.0 40930.4 41407.8 41565.4 41659.4 41745.0 1178.5 1238.7 1244.8 1252.4 1256.1 19232.6 19865.2 20747.3 20776.8 21044.4 29878.4 37684.8 38141.0 38484.6 38585.8 158953.2 161784.0 161873.0 162004.2 162077.0 30073.2 30239.8 30257.8 30537.5 30595.8 35739.5 35799.5 36004.1 36046.8 36243.6 27469.6 27630.0 27796.0 27829.6 28666.6 25979.7 26803.2 27470.9 27515.9 28595.7 29781.1 30162.7 30684.0 30906.8 30961.4 26195.9 26664.9 26739.2 26944.9 27794.7 19722.0 22065.9 22232.0 22297.6 22683.3 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | [#2] jquery.html Cycles:180 Average:23653.04 Median:38234.12 stddev:58019.58 (151.7%) stddev-sans-first:58156.07 06:19:04 INFO - PID 25547 | Values: 401.8 406.3 414.4 418.7 428.0 17025.1 17410.2 17664.6 17718.0 18375.9 18889.6 18938.3 19091.6 19128.5 19299.6 5348.4 5414.5 5629.9 5634.7 5643.8 5235.0 5301.0 5331.1 5331.2 5352.6 5277.2 5295.4 5309.5 5318.9 5328.5 5141.4 5310.6 5334.1 5355.1 5380.1 4839.9 4840.0 4845.0 4846.4 4857.2 21595.1 21597.8 21765.7 21795.9 22014.6 1594.3 1628.1 1639.8 1640.5 1643.2 13822.0 14062.9 14170.8 14208.9 14384.3 1918.0 1928.8 1965.3 2002.9 2010.1 75065.2 75598.6 75870.2 76884.6 76927.2 10837.7 11078.0 11140.4 11173.3 11233.2 15576.5 15579.2 15626.1 15630.3 15631.8 7352.4 7410.7 7510.4 7622.6 7634.9 6760.0 6770.8 6844.8 7005.3 7011.4 6682.3 6684.3 6944.3 6944.6 7062.4 1974.7 2010.9 2035.0 2040.6 2070.3 872.9 892.7 894.5 906.9 934.1 16582.7 16627.6 16891.7 16905.5 17540.1 887.4 900.9 901.7 902.8 924.3 8981.8 9515.8 9605.6 9711.2 9730.3 343276.0 345513.0 347388.0 356200.0 356640.0 72569.6 72627.0 74962.0 75716.6 75727.0 1038.2 1043.2 1066.2 1073.8 1079.9 14187.6 14436.4 14499.0 14572.7 15171.5 35569.3 37481.4 38100.0 38368.2 38471.4 45926.0 46201.8 47069.5 47218.3 48456.0 7394.3 7443.8 7458.8 7505.7 7554.7 11861.2 11960.5 12592.3 12644.7 12897.7 9466.1 10196.9 10568.8 10957.3 11051.3 9792.4 10028.9 10067.9 10209.1 10209.3 10825.9 11082.7 11118.3 11337.5 11475.3 7799.6 7979.8 8038.9 8086.9 8328.1 10226.8 10309.4 10373.7 10414.1 10801.5 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | [#3] mootools.html Cycles:180 Average:6252.37 Median:4904.16 stddev:3982.20 (81.2%) stddev-sans-first:3975.60 06:19:04 INFO - PID 25547 | Values: 1245.9 1291.1 1307.0 1311.2 1321.4 9785.0 10199.9 10335.3 10373.2 10548.5 9899.9 10043.3 10078.9 10080.9 10090.2 2134.1 2170.6 2173.9 2174.1 2185.1 2104.2 2144.0 2145.9 2155.1 2155.6 2038.6 2091.8 2097.8 2105.9 2110.8 2021.7 2024.1 2034.3 2040.7 2043.1 1942.6 1975.0 2073.6 2147.3 2148.9 9686.3 9898.0 9957.7 9962.7 9999.4 5212.4 5384.3 5391.8 5402.5 5416.4 2987.7 3017.6 3068.9 3097.7 3111.3 906.1 916.5 967.6 980.6 993.5 14101.2 14430.9 14433.9 14461.9 14473.0 4810.6 4846.9 4849.6 4958.7 4991.2 12231.0 12249.8 12254.3 12259.6 12296.6 5501.7 5606.7 5607.4 5630.8 5643.4 4976.5 5015.8 5050.3 5064.3 5085.7 4209.1 4230.4 4243.8 4254.6 4331.4 1305.6 1323.0 1364.5 1366.8 1375.2 715.3 736.8 741.5 750.8 759.8 5724.9 5825.0 6535.8 6635.9 6811.9 835.5 857.5 864.0 865.8 868.2 3780.4 3969.4 3977.7 4109.2 4140.0 12188.3 12724.4 13109.8 13135.9 13136.3 12729.0 12773.9 12993.9 13025.3 13164.2 7240.1 7362.8 7366.3 7375.2 7383.3 5620.8 5694.9 5703.3 5773.6 5909.9 11709.7 11752.7 11845.3 11933.3 11943.8 11912.6 11957.4 11963.3 12034.1 12056.5 7368.2 7423.4 7502.9 7509.4 7538.9 9440.8 9494.1 9529.7 9546.5 9576.3 7978.2 7984.8 8035.6 8080.0 8162.6 8025.1 8037.9 8039.8 8185.7 8294.6 7258.3 7282.9 7291.7 7304.3 7344.8 5354.1 5377.3 5485.9 5490.7 5591.9 5353.4 5389.3 5439.7 5494.7 5642.7 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | [#4] prototype.html Cycles:180 Average:4723.63 Median:5425.81 stddev:1440.46 (26.5%) stddev-sans-first:1406.34 06:19:04 INFO - PID 25547 | Values: 335.3 348.4 349.7 356.9 358.2 5378.2 5552.3 5554.0 5581.2 5595.7 5309.8 5409.4 5411.2 5412.9 5450.9 4026.3 4031.6 4047.7 4051.9 4052.3 3886.5 4008.6 4053.2 4054.8 4057.7 4012.8 4013.6 4021.9 4029.8 4029.9 3946.9 3994.4 4001.6 4012.0 4013.7 3453.6 3465.3 3469.8 3473.8 3486.1 5276.0 5301.4 5325.8 5373.0 5381.8 4717.8 4721.1 4734.5 4737.9 4751.2 5602.6 5776.5 5782.5 5789.5 5790.3 3880.4 3901.3 3904.2 3910.1 3911.4 5844.4 6047.5 6077.5 6114.6 6154.7 3943.8 3995.4 3996.9 4005.4 4010.8 4048.8 4065.1 4065.7 4066.8 4071.7 4558.7 4666.3 4705.1 4712.9 4747.1 5780.9 5804.1 5818.2 5834.8 5858.9 1390.7 1392.4 1392.7 1393.5 1393.6 873.2 909.7 925.6 927.5 927.8 5013.2 5074.8 5076.6 5077.2 5077.3 5973.7 5976.2 5982.7 5991.3 6006.7 4861.6 4982.2 5005.2 5021.3 5025.9 3159.9 3162.5 3175.9 3184.4 3193.8 5438.7 5545.0 5553.1 5579.4 5592.0 6060.0 6079.8 6156.0 6161.5 6215.7 5563.7 5567.0 5580.8 5592.8 5599.6 5675.8 5926.8 5978.3 6047.5 6075.2 5879.9 5900.9 5915.7 5926.7 5934.6 5312.4 5491.7 5518.2 5527.5 5572.8 3952.8 3957.2 3972.0 3976.8 3989.5 5919.5 6016.3 6025.5 6030.3 6032.9 5762.1 5782.9 5814.9 5815.7 5839.9 5768.8 5807.6 5824.9 5836.3 5842.6 5665.2 5698.9 5736.4 5752.1 5770.5 5848.7 5855.7 5863.5 5891.5 5899.2 5443.4 5631.4 5655.4 5677.7 5710.9 06:19:04 INFO - PID 25547 | 06:19:04 INFO - PID 25547 | [#5] yui.html Cycles:180 Average:17345.79 Median:3390.33 stddev:23116.28 (681.8%) stddev-sans-first:23147.48 06:19:04 INFO - PID 25547 | Values: 736.2 746.8 757.9 758.3 762.3 13508.6 14615.6 14633.6 16286.3 16739.2 16619.0 16805.2 16879.7 16881.6 16906.1 873.8 903.9 907.1 913.2 914.2 905.6 914.8 917.2 918.2 918.9 957.4 958.7 962.5 963.9 964.7 949.4 951.2 951.9 952.9 953.5 702.8 703.0 703.1 704.7 705.5 14377.9 14448.6 14872.0 14881.8 14994.0 16009.8 16422.9 16424.8 16446.9 16502.3 11909.3 12106.7 12225.1 12247.9 12283.6 2969.7 3012.7 3018.3 3019.0 3020.4 81786.2 83825.0 84114.0 84137.7 84641.2 11409.8 11431.9 11559.8 11616.2 11698.5 22498.4 23109.2 23144.0 23246.5 23271.5 5901.9 5931.9 6054.4 6095.4 6159.7 2950.9 3025.7 3032.4 3036.6 3038.3 3314.9 3381.8 3388.1 3392.5 3400.9 660.9 667.4 667.5 668.3 668.4 559.3 587.2 594.7 594.8 601.1 9147.1 9655.0 9885.0 10356.8 11071.9 562.3 564.9 565.0 574.6 575.4 4661.5 4793.2 4836.5 4848.8 4895.2 89259.0 92804.5 92827.0 93118.5 93609.5 70377.6 70854.0 70961.6 76931.6 82208.6 57420.4 57589.4 58452.0 58468.7 59692.0 9740.8 10470.9 10557.8 10814.4 11027.8 27634.0 27791.7 27820.4 29133.1 29523.0 35321.8 35435.8 35603.6 35699.8 36252.6 13707.5 13771.2 13952.5 14038.6 14210.5 15759.1 15823.9 15991.4 16229.6 16527.5 14030.2 14048.3 14366.0 14689.8 14788.3 14860.0 14942.5 15129.4 15156.7 15425.2 12541.4 12650.9 12741.5 13042.4 13153.8 9500.9 9508.1 9595.9 10365.8 10593.9 11495.0 11965.9 12055.5 12106.1 12213.2 06:19:04 INFO - PID 25547 | -------- Summary: end -------- 06:19:04 INFO - PID 25547 | 06:19:05 INFO - TEST-INFO | 25547: exit 0 06:19:05 INFO - TEST-OK | dromaeo_css | took 1146705ms 06:19:05 INFO - TEST-START | kraken 06:19:05 INFO - operating with platform_type : linux_ 06:19:05 INFO - Initialising browser for kraken test... 06:19:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50770/getInfo.html -profile /tmp/tmpDT3j57/profile 06:19:05 INFO - TEST-INFO | started process 25947 (/builds/slave/test/build/application/firefox/firefox http://localhost:50770/getInfo.html) 06:19:40 INFO - TEST-INFO | 25947: killed by SIGTERM 06:19:40 INFO - Browser initialized. 06:19:40 INFO - Running cycle 1/1 for kraken test... 06:19:40 INFO - TEST-INFO | started process 26144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDT3j57/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:52 INFO - PID 26144 | RSS: Main: 172769280 06:19:52 INFO - PID 26144 | 06:19:55 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:56 INFO - PID 26144 | RSS: Main: 178683904 06:19:56 INFO - PID 26144 | 06:19:58 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-dft) 06:19:59 INFO - PID 26144 | RSS: Main: 177360896 06:19:59 INFO - PID 26144 | 06:20:02 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-fft) 06:20:03 INFO - PID 26144 | RSS: Main: 175325184 06:20:03 INFO - PID 26144 | 06:20:05 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-oscillator) 06:20:05 INFO - PID 26144 | RSS: Main: 175763456 06:20:05 INFO - PID 26144 | 06:20:07 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:08 INFO - PID 26144 | RSS: Main: 175706112 06:20:08 INFO - PID 26144 | 06:20:11 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50770/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:12 INFO - PID 26144 | RSS: Main: 176992256 06:20:12 INFO - PID 26144 | 06:20:15 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50770/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:16 INFO - PID 26144 | RSS: Main: 175796224 06:20:16 INFO - PID 26144 | 06:20:19 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50770/tests/kraken/driver.html?testName=json-parse-financial) 06:20:20 INFO - PID 26144 | RSS: Main: 176566272 06:20:20 INFO - PID 26144 | 06:20:21 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:22 INFO - PID 26144 | RSS: Main: 176390144 06:20:22 INFO - PID 26144 | 06:20:24 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:24 INFO - PID 26144 | RSS: Main: 176201728 06:20:24 INFO - PID 26144 | 06:20:26 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:27 INFO - PID 26144 | RSS: Main: 176017408 06:20:27 INFO - PID 26144 | 06:20:30 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:31 INFO - PID 26144 | RSS: Main: 176779264 06:20:31 INFO - PID 26144 | 06:20:34 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:34 INFO - PID 26144 | RSS: Main: 176480256 06:20:34 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50770/tests/kraken/driver.html?testName=ai-astar) 06:20:36 INFO - PID 26144 | RSS: Main: 178065408 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | __start_tp_report 06:20:36 INFO - PID 26144 | _x_x_mozilla_page_load 06:20:36 INFO - PID 26144 | _x_x_mozilla_page_load_details 06:20:36 INFO - PID 26144 | |i|pagename|runs| 06:20:36 INFO - PID 26144 | |0;ai-astar;108;113;113;112;112;113;113;113;113;115 06:20:36 INFO - PID 26144 | |1;audio-beat-detection;156;125;129;179;124;126;125;123;147;124 06:20:36 INFO - PID 26144 | |2;audio-dft;165;165;164;168;171;172;171;166;164;164 06:20:36 INFO - PID 26144 | |3;audio-fft;74;74;75;109;78;78;75;75;99;75 06:20:36 INFO - PID 26144 | |4;audio-oscillator;83;84;114;84;83;83;99;84;85;102 06:20:36 INFO - PID 26144 | |5;imaging-gaussian-blur;114;115;114;114;114;115;114;114;114;114 06:20:36 INFO - PID 26144 | |6;imaging-darkroom;153;150;151;153;150;150;150;151;152;151 06:20:36 INFO - PID 26144 | |7;imaging-desaturate;97;95;95;94;94;94;95;95;94;94 06:20:36 INFO - PID 26144 | |8;json-parse-financial;55;56;55;55;56;56;57;55;55;54 06:20:36 INFO - PID 26144 | |9;json-stringify-tinderbox;57;57;58;57;58;57;58;56;57;58 06:20:36 INFO - PID 26144 | |10;stanford-crypto-aes;88;106;89;87;93;89;88;91;126;86 06:20:36 INFO - PID 26144 | |11;stanford-crypto-ccm;146;139;136;143;135;140;133;132;135;132 06:20:36 INFO - PID 26144 | |12;stanford-crypto-pbkdf2;189;202;196;196;185;189;194;198;193;192 06:20:36 INFO - PID 26144 | |13;stanford-crypto-sha256-iterative;76;72;72;75;77;72;73;75;73;72 06:20:36 INFO - PID 26144 | __end_tp_report 06:20:36 INFO - PID 26144 | __start_cc_report 06:20:36 INFO - PID 26144 | _x_x_mozilla_cycle_collect,904 06:20:36 INFO - PID 26144 | __end_cc_report 06:20:36 INFO - PID 26144 | __startTimestamp1495718436936__endTimestamp 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | ------- Summary: start ------- 06:20:36 INFO - PID 26144 | Number of tests: 14 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:0.87 06:20:36 INFO - PID 26144 | Values: 108.0 113.0 113.0 112.0 112.0 113.0 113.0 113.0 113.0 115.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:127.50 stddev:18.91 (14.8%) stddev-sans-first:18.59 06:20:36 INFO - PID 26144 | Values: 156.0 125.0 129.0 179.0 124.0 126.0 125.0 123.0 147.0 124.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#2] audio-dft Cycles:10 Average:167.00 Median:167.00 stddev:3.23 (1.9%) stddev-sans-first:3.35 06:20:36 INFO - PID 26144 | Values: 165.0 165.0 164.0 168.0 171.0 172.0 171.0 166.0 164.0 164.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:12.33 (16.4%) stddev-sans-first:12.80 06:20:36 INFO - PID 26144 | Values: 74.0 74.0 75.0 109.0 78.0 78.0 75.0 75.0 99.0 75.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:10.96 (13.0%) stddev-sans-first:11.32 06:20:36 INFO - PID 26144 | Values: 83.0 84.0 114.0 84.0 83.0 83.0 99.0 84.0 85.0 102.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:20:36 INFO - PID 26144 | Values: 114.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:1.05 06:20:36 INFO - PID 26144 | Values: 153.0 150.0 151.0 153.0 150.0 150.0 150.0 151.0 152.0 151.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:0.53 06:20:36 INFO - PID 26144 | Values: 97.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:0.84 (1.5%) stddev-sans-first:0.88 06:20:36 INFO - PID 26144 | Values: 55.0 56.0 55.0 55.0 56.0 56.0 57.0 55.0 55.0 54.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 06:20:36 INFO - PID 26144 | Values: 57.0 57.0 58.0 57.0 58.0 57.0 58.0 56.0 57.0 58.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:88.50 stddev:12.53 (14.2%) stddev-sans-first:13.08 06:20:36 INFO - PID 26144 | Values: 88.0 106.0 89.0 87.0 93.0 89.0 88.0 91.0 126.0 86.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:137.50 stddev:4.77 (3.5%) stddev-sans-first:3.82 06:20:36 INFO - PID 26144 | Values: 146.0 139.0 136.0 143.0 135.0 140.0 133.0 132.0 135.0 132.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:195.00 stddev:4.95 (2.5%) stddev-sans-first:4.99 06:20:36 INFO - PID 26144 | Values: 189.0 202.0 196.0 196.0 185.0 189.0 194.0 198.0 193.0 192.0 06:20:36 INFO - PID 26144 | 06:20:36 INFO - PID 26144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:74.00 stddev:1.89 (2.6%) stddev-sans-first:1.81 06:20:36 INFO - PID 26144 | Values: 76.0 72.0 72.0 75.0 77.0 72.0 73.0 75.0 73.0 72.0 06:20:36 INFO - PID 26144 | -------- Summary: end -------- 06:20:36 INFO - PID 26144 | 06:20:37 INFO - TEST-INFO | 26144: exit 0 06:20:38 INFO - TEST-OK | kraken | took 92624ms 06:20:38 INFO - SUITE-END | took 1239s 06:20:38 INFO - Completed test suite (00:20:39) 06:20:38 INFO - javascript benchmark 06:20:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6710.257115524943, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2694.717054709255, 2718.0622685173607, 2726.6182734417184, 2742.506348857205, 2747.848868312242, 5142.562882155022, 5241.08281050816, 5247.921281180786, 5279.076161671711, 5297.682139071653, 5157.5616072633775, 5163.096458119833, 5188.351456067991, 5269.947300527003, 5270.446603106676, 4590.954090459103, 4641.628669706432, 4690.0854333405, 4707.976460117712, 4717.858464246078, 4553.27147656375, 4641.535846415365, 4685.83599574015, 4718.9292160617615, 4730.668853180278, 4585.885352866172, 4671.182543054952, 4672.836450724209, 4740.07568524138, 4787.281907713836, 4608.423947006624, 4621.399218101626, 4655.557722016403, 4698.107359601665, 4701.106789709944, 4654.25531914892, 4664.323673067386, 4666.953330466686, 4687.484376718558, 4698.8355407560575, 5186.948130518685, 5227.372715274191, 5240.4497527759795, 5248.134057880445, 5261.921071183935, 5545.112781954868, 5626.2967129108865, 5627.212190293321, 5661.575381846378, 5713.114467257582, 5686.772529098873, 5797.420257974211, 5804.1293805929445, 5807.186993820868, 5819.67991760453, 5296.09966305729, 5299.6025298102795, 5299.682019078868, 5301.284326615858, 5305.867353316198, 5802.003641175134, 5805.071188609802, 5818.156367326714, 5830.4461076197695, 5846.269216347957, 5480.698561579072, 5573.526250268773, 5608.327000759935, 5650.4349565043985, 5655.462731040545, 5628.549716022709, 5659.971700141473, 5664.461876121762, 5676.460736230134, 5721.427857214246, 5514.365847927459, 5632.986062508788, 5633.408492108351, 5634.774609015675, 5654.97172514143, 5568.192612071227, 5635.267415236075, 5635.492805647429, 5667.4332566743, 5671.943280567224, 4708.387909571802, 4711.646626503026, 4719.0, 4738.0, 4759.833405830779, 4050.7569545827346, 4060.5939406059156, 4101.282275601758, 4104.076582768913, 4123.670106391482, 4731.550502702238, 4784.378030856036, 4805.231163013901, 4805.951940480621, 4836.0, 5442.809501667422, 5477.123660214346, 5507.03626865297, 5528.530074943675, 5638.577106717013, 4831.371921650163, 4832.0, 4840.878978025507, 4856.562909338177, 4877.341558889575, 5005.274235235943, 5018.096742586369, 5030.622703297194, 5063.5695965843315, 5064.746762661852, 5183.352080989876, 5193.298904647824, 5260.842174734764, 5271.894562108813, 5283.630145889751, 5747.48272655463, 5747.97126014384, 5756.625819321731, 5772.9711351442975, 5805.593608447537, 5233.581313494835, 5251.632385732962, 5314.3091398117995, 5326.467353264643, 5357.78568857257, 5492.69790161529, 5599.748011339418, 5609.943900560942, 5628.296462942132, 5646.88706225865, 5646.435356464321, 5713.771449141987, 5737.483626473638, 5750.654960702204, 5754.395788442321, 5424.83725488236, 5479.2602998594675, 5488.506034456918, 5509.173623956439, 5550.777968881361, 5559.58303127259, 5567.860803479945, 5569.777208911761, 5570.526505246938, 5571.192177134374, 5333.359996800409, 5350.250964864844, 5493.917591236055, 5514.862128446661, 5550.5282051026115, 5493.121100623881, 5574.749136288796, 5576.609637325349, 5577.553795696415, 5585.218069470358, 5416.133418652997, 5416.83749487516, 5423.83728488146, 5431.646942948696, 5454.154606036071], "value": 5135.354807857671, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.1358663357685, 700.3276854219948, 726.5931078595987, 1047.099494434786, 1076.2358725305032, 33141.33717325655, 33711.15722106949, 33961.83019084901, 34128.146796330104, 34134.14664633385, 35425.46861797075, 35489.467657985086, 35711.821440892825, 35858.8207058965, 35993.46009809855, 6462.772073306057, 6648.833779155536, 6883.724651013966, 7014.789556313293, 7018.9298107018785, 6530.379613936669, 6621.0, 6629.204495460527, 6632.734690612369, 6636.236832764245, 6612.404883560479, 6618.106555614979, 6667.466602671775, 6674.499412544054, 6686.197656281229, 6546.607203567801, 6576.572522786051, 6586.242582103072, 6631.336866313378, 6642.767503137416, 6547.672616369163, 6562.868742625121, 6598.076269322299, 6615.106960560311, 6618.867622647568, 32090.0, 32178.0, 32206.838965805255, 32212.35575288481, 32375.514367284508, 3052.0996306089755, 3085.059056987618, 3088.382323535302, 3098.9690103098906, 3104.472239719253, 24421.755782442127, 24458.388540286458, 24527.632085518733, 24599.508009839883, 24642.630360544605, 2591.20968104728, 2683.235277945776, 2701.162639581736, 2720.91837244883, 2737.8083534152615, 141899.0, 142119.0, 142289.0, 150428.0, 154142.0, 39728.0, 39829.402558961636, 39984.400233996515, 40085.79957100196, 40132.398014029815, 41835.58164418317, 41835.581644183774, 41853.0, 41858.1628367431, 44760.0, 11868.0, 11951.402429878472, 11957.52169913211, 11967.820482692767, 12056.457459414347, 9425.340226184238, 9445.811083778424, 9472.810543789223, 9485.336026478219, 9488.620455181854, 12948.870511294956, 12998.740025199442, 13016.15394999322, 13094.011478290242, 13170.407331669907, 5427.6200665953, 5428.348598168166, 5510.393856675762, 5591.273134492571, 5667.044869520009, 861.1001503428931, 886.9157430044136, 924.3252425729121, 928.7028150991617, 943.4763706143157, 20333.763286038524, 20779.58440831205, 21286.0, 21365.46586335354, 21780.0, 984.3650845204803, 992.6575331510618, 1000.8048430556117, 1002.6490728245055, 1025.123519390925, 10639.521221544894, 10992.450377481255, 11274.830877536844, 11321.886781132249, 11391.943040284745, 170625.0, 170814.0, 171053.0, 171571.0, 172070.0, 40930.38604420936, 41407.792961035004, 41565.376519352234, 41659.37510937338, 41745.0, 1178.5168081086713, 1238.7055526974334, 1244.8381710377594, 1252.4489224741085, 1256.0767835640797, 19232.61534769269, 19865.205391784166, 20747.27384541594, 20776.79223207809, 21044.368668939955, 29878.402431951676, 37684.811575941945, 38141.0, 38484.615153848106, 38585.80707096559, 158953.2052339731, 161784.0, 161873.0, 162004.18997904935, 162077.0, 30073.24816879508, 30239.848800755855, 30257.848710756305, 30537.54193687052, 30595.847020764755, 35739.49823512433, 35799.46300805542, 36004.09989750277, 36046.81976590205, 36243.63756362403, 27469.587956181073, 27630.0, 27796.0, 27829.582556261266, 28666.570001449578, 25979.74020259773, 26803.19590412291, 27470.862645686644, 27515.86242068777, 28595.714042859305, 29781.10656680303, 30162.69837301687, 30684.0, 30906.845465772527, 30961.380772383975, 26195.869020654776, 26664.866675666497, 26739.197824065308, 26944.865275673495, 27794.722052780024, 19722.0, 22065.889670551544, 22232.0, 22297.554048918606, 22683.319500415015], "value": 14460.70682428691, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.80110845131645, 406.27074401449397, 414.43015853201837, 418.6922611880268, 427.9935800962984, 17025.14874256287, 17410.216540255686, 17664.558386040357, 17718.0, 18375.90812045941, 18889.62220755584, 18938.337158199465, 19091.61816763664, 19128.521786955298, 19299.614007719836, 5348.411674715778, 5414.512693857552, 5629.9437005629825, 5634.7182640867795, 5643.774249030034, 5234.973825130869, 5300.973495132519, 5331.067063263913, 5331.2003199519995, 5352.625316227865, 5277.208418737201, 5295.443978382272, 5309.469053094698, 5318.893622127574, 5328.520433161015, 5141.434442211354, 5310.575153987672, 5334.11987022139, 5355.0628639988045, 5380.139177731544, 4839.911020020502, 4839.975800121012, 4845.030993801219, 4846.442659094178, 4857.247126695368, 21595.1361945522, 21597.784022159736, 21765.67351489713, 21795.891020544797, 22014.559708805893, 1594.2825728422256, 1628.071998960593, 1639.7950256217973, 1640.5078476457134, 1643.1948345310711, 13822.0, 14062.859371406257, 14170.787438188436, 14208.92895535526, 14384.28078596066, 1917.9520511987173, 1928.8264056234866, 1965.263026365113, 2002.8898410587412, 2010.1155491583656, 75065.24934750637, 75598.62200689016, 75870.24129758686, 76884.61557692231, 76927.23072769257, 10837.729056773644, 11078.0, 11140.442977851075, 11173.273737207055, 11233.213675042669, 15576.454824081104, 15579.221038948008, 15626.140562268956, 15630.29663665115, 15631.765523517157, 7352.411807055422, 7410.703571857065, 7510.399168066541, 7622.618869056636, 7634.923650763532, 6760.0, 6770.763023294161, 6844.794656160323, 7005.299470053056, 7011.439084873198, 6682.264950855402, 6684.331566843374, 6944.270851560514, 6944.618046007518, 7062.364387205176, 1974.6741787605172, 2010.8894010829251, 2034.9898250508652, 2040.6234298591826, 2070.254708305009, 872.8952525696957, 892.7187935800202, 894.5303715549388, 906.909309069101, 934.0892629686002, 16582.668346633, 16627.584310392096, 16891.662166756596, 16905.49283521496, 17540.122993850255, 887.3566664168555, 900.8603666431713, 901.7204666553389, 902.8329758994607, 924.3390975452584, 8981.820363592691, 9515.762105947406, 9605.567749451291, 9711.223102151811, 9730.270229732798, 343276.0, 345513.0, 347388.0, 356200.0, 356640.0, 72569.6371518139, 72627.0, 74962.0, 75716.62141689257, 75727.0, 1038.2213339995003, 1043.1915265669168, 1066.1630619963446, 1073.8442925775876, 1079.875814281352, 14187.574372768833, 14436.350364233846, 14499.0, 14572.708545828811, 15171.468998584996, 35569.28861422705, 37481.4377784328, 38100.0, 38368.2326353477, 38471.422928656655, 45926.0, 46201.76899115483, 47069.52930470651, 47218.29172562483, 48456.0, 7394.2975417335265, 7443.813904652427, 7458.776236712907, 7505.737299194502, 7554.66004029809, 11861.229020113666, 11960.521579137085, 12592.307423091817, 12644.683882902633, 12897.677558061123, 9466.05339466048, 10196.898031019595, 10568.788624227318, 10957.342559446459, 11051.281666691639, 9792.412455252708, 10028.949855250678, 10067.949660251945, 10209.132223761064, 10209.336393134423, 10825.945870270598, 11082.667519974413, 11118.332900026024, 11337.546498139982, 11475.254108482923, 7799.610019499116, 7979.840403191787, 8038.919610803817, 8086.908267384063, 8328.125546817497, 10226.795464090825, 10309.432981186106, 10373.688789336333, 10414.114800242065, 10801.513931872927], "value": 8601.774307275855, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.8629550749417, 1291.1459294007386, 1306.9803952940701, 1311.1543054729696, 1321.4383886848086, 9785.0, 10199.949000255006, 10335.276530642857, 10373.17014638829, 10548.525316360763, 9899.901000989988, 10043.347182433137, 10078.899211007887, 10080.949595252032, 10090.192784577235, 2134.1036764558844, 2170.6201414752436, 2173.89130543473, 2174.065151984646, 2185.1259496201487, 2104.221438067917, 2144.04589957469, 2145.903434345458, 2155.051777218027, 2155.622766015949, 2038.551518665891, 2091.811736943675, 2097.83217342613, 2105.894705264738, 2110.778368271325, 2021.6866385710239, 2024.0992758222596, 2034.3286715383888, 2040.6530889748778, 2043.1010355443557, 1942.6118436019526, 1975.0223639298495, 2073.6060148571873, 2147.3235930681785, 2148.9355319340443, 9686.273529485246, 9898.0, 9957.651482198089, 9962.651307204213, 9999.35004224723, 5212.4266330703595, 5384.273123128367, 5391.757370918318, 5402.486763757437, 5416.350037995466, 2987.671356150822, 3017.5926249956196, 3068.861901214451, 3097.674744151877, 3111.3466172103886, 906.1436942089728, 916.4684482999844, 967.6081187119228, 980.6224603527693, 993.5181437003048, 14101.224432656303, 14430.855691443056, 14433.92783036078, 14461.855381446156, 14472.999999999894, 4810.6151507879285, 4846.903061938741, 4849.636277279147, 4958.677685950402, 4991.151504244287, 12231.0, 12249.816252756216, 12254.264744115382, 12259.570915017932, 12296.631101066982, 5501.697406642593, 5606.719664016864, 5607.4112218217315, 5630.774769009194, 5643.35101463337, 4976.477469865612, 5015.824446144367, 5050.292958985745, 5064.265681476239, 5085.720285384339, 4209.137126888981, 4230.428892099589, 4243.830246790094, 4254.574542545721, 4331.371951067141, 1305.5887395470397, 1322.9867701323055, 1364.515596963064, 1366.7881478370869, 1375.2023826180991, 715.345458905096, 736.7900148457663, 741.4809633256634, 750.7597568777938, 759.7910574592031, 5724.914126288109, 5825.03886858672, 6535.771248006297, 6635.86728265432, 6811.931880681229, 835.5404527509967, 857.4812238595684, 863.96976105836, 865.8311629232239, 868.2489646455897, 3780.3573392523335, 3969.4244334571326, 3977.7414468059483, 4109.198706252252, 4139.97930010348, 12188.268703877618, 12724.427400766988, 13109.803352949713, 13135.868641313464, 13136.34318284101, 12729.0, 12773.936130319289, 12993.935030324788, 13025.348732563334, 13164.210147391188, 7240.1311842579225, 7362.779116626402, 7366.263373662698, 7375.151857536344, 7383.2616738326815, 5620.803271885465, 5694.857628559319, 5703.344115426779, 5773.595848290747, 5909.852253693692, 11709.707257318294, 11752.70618234551, 11845.289282642725, 11933.28400295985, 11943.76112477763, 11912.583059592873, 11957.402129893297, 11963.342016189194, 12034.097442691658, 12056.51773929033, 7368.189499155196, 7423.443241756998, 7502.924970750222, 7509.4367922404945, 7538.924610754042, 9440.763980900532, 9494.098060684224, 9529.666461673809, 9546.522673866419, 9576.281778866474, 7978.197955810192, 7984.842197881158, 8035.558044307385, 8079.959600201962, 8162.551059691774, 8025.07711613172, 8037.879431808645, 8039.799005024921, 8185.672573097009, 8294.626741796514, 7258.274172582699, 7282.927170728437, 7291.744788932362, 7304.342609164988, 7344.779656610311, 5354.143337066051, 5377.27406800077, 5485.890282194254, 5490.670559766427, 5591.888162236651, 5353.437889021752, 5389.326334208224, 5439.728013599225, 5494.670319780826, 5642.7460764266525], "value": 4723.889435270041, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.33268795097763, 348.43727380280825, 349.6730556929271, 356.9107723069231, 358.17619475207016, 5378.193271009351, 5552.250446189763, 5553.972230138854, 5581.190727344538, 5595.740958284384, 5309.814156504523, 5409.377921539024, 5411.242426060355, 5412.891742165154, 5450.890982180354, 4026.315526360526, 4031.5565287818317, 4047.736897101679, 4051.9392209116886, 4052.257529262416, 3886.514185726784, 4008.5590585035625, 4053.1893621275717, 4054.797260136996, 4057.6753859691303, 4012.8194231259663, 4013.6187062229187, 4021.939670904939, 4029.758214507124, 4029.919401611966, 3946.9210615787524, 3994.4008398740275, 4001.639852413268, 4011.97994010031, 4013.7391069580385, 3453.637368076341, 3465.28961562879, 3469.826508674556, 3473.808940508271, 3486.0936156599214, 5276.0, 5301.416844147141, 5325.813596524142, 5373.0, 5381.7578208980685, 4717.839047837922, 4721.102990431841, 4734.526547345273, 4737.857864264078, 4751.216049351853, 5602.551795856321, 5776.5089967352405, 5782.45066718661, 5789.478946894799, 5790.334111577138, 3880.4373365862075, 3901.31726947783, 3904.1606054698377, 3910.081130934228, 3911.413288006793, 5844.386339434383, 6047.546434017467, 6077.513798896078, 6114.571979961404, 6154.692265386713, 3943.8028098594955, 3995.380715989026, 3996.8800935971385, 4005.35914253718, 4010.8195131219163, 4048.777317247521, 4065.0650350418978, 4065.715399921977, 4066.7763273019677, 4071.714979951375, 4558.697857581966, 4666.346711460398, 4705.12955103307, 4712.882177945578, 4747.121782470254, 5780.913286300709, 5804.1293805929445, 5818.185454036438, 5834.824955251349, 5858.912116318259, 1390.7009992851383, 1392.4291040673274, 1392.7284179584883, 1393.4983405973842, 1393.6306878677158, 873.2359185712502, 909.7407238936871, 925.5696101312922, 927.4759760735163, 927.8283517549276, 5013.197888337849, 5074.771635276422, 5076.568491678175, 5077.162268225775, 5077.26379674945, 5973.701314934236, 5976.207137858712, 5982.73077711504, 5991.340952495222, 6006.729697163638, 4861.565838077776, 4982.160168703804, 5005.224190250517, 5021.297018417425, 5025.939364860463, 3159.936801263962, 3162.525621156845, 3175.9039034237753, 3184.4268031754505, 3193.7803226757646, 5438.721900353414, 5545.0, 5553.111502159635, 5579.358373786985, 5591.9720401397735, 6059.969700151471, 6079.787207447718, 6155.969220153871, 6161.507079433634, 6215.689215539205, 5563.749631266603, 5566.972165139148, 5580.804671836466, 5592.832215033555, 5599.608027438122, 5675.772969081356, 5926.7925622603, 5978.282606087298, 6047.5464340173785, 6075.210222671025, 5879.882402351844, 5900.940990590211, 5915.674637894957, 5926.674032928058, 5934.584579079596, 5312.38907525624, 5491.697956612425, 5518.227448157181, 5527.53015993645, 5572.77708891656, 3952.7628342299554, 3957.22834047358, 3971.980140099281, 3976.7613943162346, 3989.501312335958, 5919.4968427684125, 6016.308124565731, 6025.487833534199, 6030.276366835832, 6032.90950635732, 5762.135679648086, 5782.860341673608, 5814.912776308443, 5815.680137592473, 5839.926825976717, 5768.826935191951, 5807.593468457337, 5824.94175058244, 5836.270466191726, 5842.591018628826, 5665.150227465913, 5698.857528561819, 5736.447280959933, 5752.0509115997065, 5770.538356931519, 5848.707564621837, 5855.707214639337, 5863.501602363847, 5891.49922256613, 5899.203607512931, 5443.4284400138995, 5631.380548139783, 5655.4344565543115, 5677.659340439587, 5710.857228569319], "value": 4267.177151613502, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.2196072163507, 746.7610364683296, 757.9421869623969, 758.3288789421363, 762.3101093510371, 13508.594742157738, 14615.634609134777, 14633.560993170195, 16286.267117979689, 16739.246733897005, 16619.0, 16805.15974201291, 16879.746803797952, 16881.577960550963, 16906.07016614089, 873.8470767615642, 903.8824952756149, 907.0929070929071, 913.2374467319796, 914.1635403605693, 905.5698543191965, 914.8490499067645, 917.2432742987029, 918.2011649864627, 918.9127032931895, 957.3968399908048, 958.7363475044349, 962.4995002598645, 963.9180669643089, 964.6912987843892, 949.3544389814923, 951.2104952889085, 951.9095685909828, 952.8618350339232, 953.537534295866, 702.764573867755, 703.022798310349, 703.0824773670358, 704.7462913351189, 705.5272967112047, 14377.856221437756, 14448.638784030378, 14872.033317834306, 14881.776773348409, 14994.0, 16009.839901600952, 16422.917885410498, 16424.75362869558, 16446.917765411217, 16502.33990640373, 11909.344986025764, 12106.697332566668, 12225.144239903211, 12247.877521224851, 12283.57007504733, 2969.7178768017, 3012.6535448423274, 3018.3208778024987, 3018.9698103019127, 3020.365723198131, 81786.18213817905, 83825.0, 84114.0, 84137.73793393104, 84641.15358846395, 11409.828852567218, 11431.942840285912, 11559.76880462386, 11616.186866919403, 11698.532058717727, 22498.437539061328, 23109.19117830868, 23144.0, 23246.53506929852, 23271.53456930852, 5901.911471327933, 5931.9406805931385, 6054.364291749391, 6095.3904609538695, 6159.6612186330185, 2950.867210975511, 3025.667176610571, 3032.3935212957495, 3036.6356037275227, 3038.270815004383, 3314.867405303809, 3381.7801842880626, 3388.1360253135294, 3392.525046493493, 3400.931981360359, 660.9140811694449, 667.4060086522999, 667.4760313154151, 668.2982867988593, 668.4418510543653, 559.3120461831969, 587.2424572301768, 594.6848170469658, 594.7888499582673, 601.1433706967641, 9147.0852914708, 9654.951725241328, 9884.950575247078, 10356.844647330296, 11071.944640276746, 562.2578196780211, 564.9463300986399, 565.028151579283, 574.5977815529146, 575.4159528079003, 4661.463931647904, 4793.209120495149, 4836.46798852126, 4848.8302909398, 4895.241237608177, 89259.0, 92804.53597731968, 92827.0, 93118.53440732753, 93609.53195234116, 70377.64811175912, 70854.0, 70961.64519177371, 76931.61534192406, 82208.58895705483, 57420.42579574235, 57589.424105759244, 58452.0, 58468.70765646145, 59692.0, 9740.756481087747, 10470.947645261725, 10557.78884422292, 10814.351138931375, 11027.83458248111, 27634.0, 27791.722082778913, 27820.44359112766, 29133.086691330696, 29523.0, 35321.823390882884, 35435.82282088573, 35603.64396356003, 35699.82150089233, 36252.63747362493, 13707.520236791665, 13771.242581658105, 13952.511662091778, 14038.649033774238, 14210.502632407815, 15759.13324767103, 15823.920880395524, 15991.360345586047, 16229.59426014359, 16527.50417487477, 14030.158190508602, 14048.2975851205, 14366.0, 14689.779653305422, 14788.334524946187, 14860.0, 14942.477013304482, 15129.39482420735, 15156.696866062837, 15425.228738563252, 12541.372931353213, 12650.936745316214, 12741.49034038628, 13042.413091410719, 13153.802692959805, 9500.857487137837, 9508.144267016001, 9595.856062159213, 10365.84451233217, 10593.947030264799, 11495.0, 11965.940170299093, 12055.457504412498, 12106.07492910081, 12213.206141600767], "value": 7089.487228244197, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 115.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 129.0, 179.0, 124.0, 126.0, 125.0, 123.0, 147.0, 124.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 168.0, 171.0, 172.0, 171.0, 166.0, 164.0, 164.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 109.0, 78.0, 78.0, 75.0, 75.0, 99.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 84.0, 83.0, 83.0, 99.0, 84.0, 85.0, 102.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 151.0, 153.0, 150.0, 150.0, 150.0, 151.0, 152.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 57.0, 55.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 58.0, 57.0, 58.0, 56.0, 57.0, 58.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 106.0, 89.0, 87.0, 93.0, 89.0, 88.0, 91.0, 126.0, 86.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 136.0, 143.0, 135.0, 140.0, 133.0, 132.0, 135.0, 132.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 202.0, 196.0, 196.0, 185.0, 189.0, 194.0, 198.0, 193.0, 192.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 72.0, 75.0, 77.0, 72.0, 73.0, 75.0, 73.0, 72.0], "value": 73.7, "unit": "score"}]}]} 06:20:38 INFO - Return code: 0 06:20:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:20:38 INFO - # TBPL SUCCESS # 06:20:38 INFO - Running post-action listener: _resource_record_post_action 06:20:38 INFO - [mozharness: 2017-05-25 13:20:38.248639Z] Finished run-tests step (success) 06:20:38 INFO - Running post-run listener: _resource_record_post_run 06:20:38 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 8192; Write bytes: 399691776; Read time: 108; Write time: 386052 06:20:38 INFO - TinderboxPrint: CPU usage
12.8% 06:20:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 108 06:20:38 INFO - TinderboxPrint: I/O write bytes / time
399,691,776 / 386,052 06:20:38 INFO - TinderboxPrint: CPU idle
8,744.4 (87.2%) 06:20:38 INFO - TinderboxPrint: CPU user
1,224.7 (12.2%) 06:20:38 INFO - TinderboxPrint: Swap in / out
0 / 0 06:20:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 97386496; Read time: 0; Write time: 163648 06:20:38 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302305280; Read time: 88; Write time: 222404 06:20:38 INFO - Running post-run listener: _upload_blobber_files 06:20:38 INFO - Blob upload gear active. 06:20:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:20:38 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 06:20:38 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'] 06:20:38 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 06:20:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:20:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:40 INFO - (blobuploader) - INFO - Done attempting. 06:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:41 INFO - (blobuploader) - INFO - Done attempting. 06:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:41 INFO - (blobuploader) - INFO - Done attempting. 06:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:20:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:44 INFO - (blobuploader) - INFO - Done attempting. 06:20:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:45 INFO - Return code: 0 06:20:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7deee6ffe318795dafaf4dfe15583a28bd6d87456ca73422d302e77c88e4b840e05c319ae7dcdc695cb777e993a40438d807f3663dadaf2e26252d30c252ce2d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/469e1af62e49365f68196c1a43924ca6392a688a8e25a13908bc98d26aa40e0ac46915a9df8b4d9cf307ea9b86e6f3d84c902cfa55c79bc2ff65c09e547eb824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b6a26bea014744595cfd22fcbb53c5ee91ece62d26089dba9253e6ce651634e0ba5d9d212f92f4b932065f69a1315f200f73b0101fa0efbcd79d174c6e2493b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daf28b7301be88f232a4649e702db2a199f02d3583a31a11505c4bad12e4d7db0dee1fa7e1cff5ca94e80f18dd1fa3460f11b200d7be03344ad2734ef1f5217b"} 06:20:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:45 INFO - Contents: 06:20:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7deee6ffe318795dafaf4dfe15583a28bd6d87456ca73422d302e77c88e4b840e05c319ae7dcdc695cb777e993a40438d807f3663dadaf2e26252d30c252ce2d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/469e1af62e49365f68196c1a43924ca6392a688a8e25a13908bc98d26aa40e0ac46915a9df8b4d9cf307ea9b86e6f3d84c902cfa55c79bc2ff65c09e547eb824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b6a26bea014744595cfd22fcbb53c5ee91ece62d26089dba9253e6ce651634e0ba5d9d212f92f4b932065f69a1315f200f73b0101fa0efbcd79d174c6e2493b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daf28b7301be88f232a4649e702db2a199f02d3583a31a11505c4bad12e4d7db0dee1fa7e1cff5ca94e80f18dd1fa3460f11b200d7be03344ad2734ef1f5217b"} 06:20:45 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:45 INFO - Copying logs to upload dir... 06:20:45 INFO - mkdir: /builds/slave/test/build/upload/logs 06:20:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.299434 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-25 06:20:44.802029) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 06:20:44.809919) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927 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/7deee6ffe318795dafaf4dfe15583a28bd6d87456ca73422d302e77c88e4b840e05c319ae7dcdc695cb777e993a40438d807f3663dadaf2e26252d30c252ce2d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/469e1af62e49365f68196c1a43924ca6392a688a8e25a13908bc98d26aa40e0ac46915a9df8b4d9cf307ea9b86e6f3d84c902cfa55c79bc2ff65c09e547eb824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b6a26bea014744595cfd22fcbb53c5ee91ece62d26089dba9253e6ce651634e0ba5d9d212f92f4b932065f69a1315f200f73b0101fa0efbcd79d174c6e2493b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daf28b7301be88f232a4649e702db2a199f02d3583a31a11505c4bad12e4d7db0dee1fa7e1cff5ca94e80f18dd1fa3460f11b200d7be03344ad2734ef1f5217b"} build_url:https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/WJayXDDIQLG2B5srHbla3A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7deee6ffe318795dafaf4dfe15583a28bd6d87456ca73422d302e77c88e4b840e05c319ae7dcdc695cb777e993a40438d807f3663dadaf2e26252d30c252ce2d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/469e1af62e49365f68196c1a43924ca6392a688a8e25a13908bc98d26aa40e0ac46915a9df8b4d9cf307ea9b86e6f3d84c902cfa55c79bc2ff65c09e547eb824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b6a26bea014744595cfd22fcbb53c5ee91ece62d26089dba9253e6ce651634e0ba5d9d212f92f4b932065f69a1315f200f73b0101fa0efbcd79d174c6e2493b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daf28b7301be88f232a4649e702db2a199f02d3583a31a11505c4bad12e4d7db0dee1fa7e1cff5ca94e80f18dd1fa3460f11b200d7be03344ad2734ef1f5217b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 06:20:44.837337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:20:44.837753) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495712566.174458-336482927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:20:44.922602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 06:20:44.922993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 06:20:44.923381) ========= ========= Total master_lag: 0.19 =========