builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1504030284.63 results: success (0) revision: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.636122) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.636736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.637012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.653536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.653898) ========= 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-1504027759.962957-1839089101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-29 11:11:24-- 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% 34.6M=0s 2017-08-29 11:11:24 (34.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120837 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.801736) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.802059) ========= 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-1504027759.962957-1839089101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020325 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:24.855130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-29 11:11:24.858535) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 --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 e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 --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-1504027759.962957-1839089101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-29 11:11:25,099 truncating revision to first 12 chars 2017-08-29 11:11:25,099 Setting DEBUG logging. 2017-08-29 11:11:25,099 attempt 1/10 2017-08-29 11:11:25,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e336d84fc1d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-29 11:11:25,637 attempt 1/10 2017-08-29 11:11:26,186 current task status: no status available at this point. state: STARTED 2017-08-29 11:11:26,186 sleeping for 11.00s (attempt 1/10) 2017-08-29 11:11:37,197 attempt 2/10 2017-08-29 11:11:37,558 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-29 11:11:37,993 unpacking tar archive at: mozilla-central-e336d84fc1d2/testing/mozharness/ program finished with exit code 0 elapsedTime=13.179447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-29 11:11:38.052697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:38.053035) ========= script_repo_revision: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:38.056694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:38.057080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 11:11:38.069168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-29 11:11:38.069568) ========= /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-1504027759.962957-1839089101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:38 INFO - MultiFileLogger online at 20170829 11:11:38 in /builds/slave/test 11:11:38 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 11:11:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:38 INFO - {'append_to_log': False, 11:11:38 INFO - 'base_work_dir': '/builds/slave/test', 11:11:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:11:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:38 INFO - 'branch': 'Firefox-Non-PGO', 11:11:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:38 INFO - 'code_coverage': False, 11:11:38 INFO - 'config_files': ('talos/linux_config.py',), 11:11:38 INFO - 'default_actions': ('clobber', 11:11:38 INFO - 'read-buildbot-config', 11:11:38 INFO - 'download-and-extract', 11:11:38 INFO - 'populate-webroot', 11:11:38 INFO - 'create-virtualenv', 11:11:38 INFO - 'install', 11:11:38 INFO - 'setup-mitmproxy', 11:11:38 INFO - 'run-tests'), 11:11:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:38 INFO - 'disable_ccov_upload': False, 11:11:38 INFO - 'download_minidump_stackwalk': True, 11:11:38 INFO - 'download_symbols': 'ondemand', 11:11:38 INFO - 'enable_stylo': False, 11:11:38 INFO - 'enable_webrender': False, 11:11:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:11:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:38 INFO - 'gecko_profile': False, 11:11:38 INFO - 'gecko_profile_interval': 0, 11:11:38 INFO - 'installer_path': 'installer.exe', 11:11:38 INFO - 'log_level': 'info', 11:11:38 INFO - 'log_name': 'talos', 11:11:38 INFO - 'log_to_console': True, 11:11:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:38 INFO - 'opt_config_files': (), 11:11:38 INFO - 'pip_index': False, 11:11:38 INFO - 'suite': 'dromaeojs-e10s', 11:11:38 INFO - 'system_bits': '32', 11:11:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:38 INFO - 'title': 'talos-linux64-ix-029', 11:11:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:38 INFO - 'use_talos_json': True, 11:11:38 INFO - 'verify': 'False', 11:11:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:38 INFO - 'work_dir': 'build'} 11:11:38 INFO - [mozharness: 2017-08-29 18:11:38.456286Z] Running clobber step. 11:11:38 INFO - Running pre-action listener: _resource_record_pre_action 11:11:38 INFO - Running main action method: clobber 11:11:38 INFO - rmtree: /builds/slave/test/build 11:11:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:39 INFO - Running post-action listener: _resource_record_post_action 11:11:39 INFO - [mozharness: 2017-08-29 18:11:39.991006Z] Finished clobber step (success) 11:11:39 INFO - [mozharness: 2017-08-29 18:11:39.991103Z] Running read-buildbot-config step. 11:11:39 INFO - Running pre-action listener: _resource_record_pre_action 11:11:39 INFO - Running main action method: read_buildbot_config 11:11:39 INFO - Using buildbot properties: 11:11:39 INFO - { 11:11:39 INFO - "project": "", 11:11:39 INFO - "product": "firefox", 11:11:39 INFO - "who": "ffxbld@noreply.mozilla.org", 11:11:39 INFO - "installer_path": "public/build/target.tar.bz2", 11:11:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:11:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:11:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:11:39 INFO - "stage_platform": "linux64", 11:11:39 INFO - "basedir": "/builds/slave/test", 11:11:39 INFO - "buildnumber": 797, 11:11:39 INFO - "platform": "ubuntu64_hw", 11:11:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:11:39 INFO - "slavebuilddir": "test", 11:11:39 INFO - "taskId": "PiW0J5CNTGm4kLikoD0ksA", 11:11:39 INFO - "branch": "mozilla-central", 11:11:39 INFO - "script_repo_revision": "production", 11:11:39 INFO - "revision": "e336d84fc1d2d1fde7387dd5f86fe06fa59abe10", 11:11:39 INFO - "slavename": "talos-linux64-ix-029", 11:11:39 INFO - "repo_path": "mozilla-central" 11:11:39 INFO - } 11:11:39 INFO - Finding installer, test and symbols from parent task. 11:11:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PiW0J5CNTGm4kLikoD0ksA'}, attempt #1 11:11:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PiW0J5CNTGm4kLikoD0ksA'}, attempt #1 11:11:40 INFO - Task dependencies: J1Wwa5wdSOSum0rQh28Tpg 11:11:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg'}, attempt #1 11:11:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:11:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json 11:11:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.crashreporter-symbols.zip 11:11:41 INFO - Running post-action listener: _resource_record_post_action 11:11:41 INFO - [mozharness: 2017-08-29 18:11:41.372260Z] Finished read-buildbot-config step (success) 11:11:41 INFO - [mozharness: 2017-08-29 18:11:41.372475Z] Running download-and-extract step. 11:11:41 INFO - Running pre-action listener: _resource_record_pre_action 11:11:41 INFO - Running main action method: download_and_extract 11:11:41 INFO - mkdir: /builds/slave/test/build/tests 11:11: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')]} 11:11:41 INFO - trying https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json 11:11:41 INFO - Downloading https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:11:41 INFO - Downloaded 989 bytes. 11:11:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:11:41 INFO - Using the following test package requirements: 11:11:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:11:41 INFO - u'common': [u'target.common.tests.zip'], 11:11:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:11:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:11:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:11:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:11:41 INFO - u'mozbase': [u'target.common.tests.zip'], 11:11:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:11:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:11:41 INFO - u'web-platform': [u'target.common.tests.zip', 11:11:41 INFO - u'target.web-platform.tests.tar.gz'], 11:11:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:11:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:11:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip 11:11:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:11:41 INFO - Fetch https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip into memory 11:11:43 INFO - Content-Length response header: 54977655 11:11:43 INFO - Bytes received: 54977655 11:11:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:11:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip 11:11:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:11:53 INFO - Fetch https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.common.tests.zip into memory 11:11:55 INFO - Content-Length response header: 54977655 11:11:55 INFO - Bytes received: 54977655 11:12:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.talos.tests.zip 11:12:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:12:07 INFO - Fetch https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.talos.tests.zip into memory 11:12:08 INFO - Content-Length response header: 14496611 11:12:08 INFO - Bytes received: 14496611 11:12:08 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')]} 11:12:08 INFO - trying https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:12:08 INFO - Downloading https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:12:09 INFO - Downloaded 61283835 bytes. 11:12:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:12:09 INFO - mkdir: /builds/slave/test/properties 11:12:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:09 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:09 INFO - Contents: 11:12:09 INFO - build_url:https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 11:12:09 INFO - Running post-action listener: _resource_record_post_action 11:12:09 INFO - Running post-action listener: find_tests_for_verification 11:12:09 INFO - Running post-action listener: set_extra_try_arguments 11:12:09 INFO - [mozharness: 2017-08-29 18:12:09.821347Z] Finished download-and-extract step (success) 11:12:09 INFO - [mozharness: 2017-08-29 18:12:09.821444Z] Running populate-webroot step. 11:12:09 INFO - Running pre-action listener: _resource_record_pre_action 11:12:09 INFO - Running main action method: populate_webroot 11:12:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:09 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:09 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:09 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'tests': ['damp', 'tps']}, 11:12:09 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['damp', 'tps']}, 11:12:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:12:09 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:12:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:12:09 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:12:09 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_many_windows', 11:12:09 INFO - 'sessionrestore_no_auto_restore', 11:12:09 INFO - 'tabpaint']}, 11:12:09 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_many_windows', 11:12:09 INFO - 'sessionrestore_no_auto_restore', 11:12:09 INFO - 'tabpaint']}, 11:12:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:12:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:12:09 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['bloom_basic_singleton']}, 11:12:09 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['bloom_basic']}, 11:12:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:09 INFO - 'tsvgr_opacity', 11:12:09 INFO - 'tart', 11:12:09 INFO - 'tscrollx', 11:12:09 INFO - 'tsvg_static']}, 11:12:09 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['tsvgx', 11:12:09 INFO - 'tsvgr_opacity', 11:12:09 INFO - 'tart', 11:12:09 INFO - 'tscrollx', 11:12:09 INFO - 'tsvg_static']}, 11:12:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:12:09 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'talos_options': ['--stylo'], 11:12:09 INFO - 'tests': ['tp5o']}, 11:12:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:09 INFO - 'talos_options': ['--mitmproxy', 11:12:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:09 INFO - '--firstNonBlankPaint'], 11:12:09 INFO - 'tests': ['tp6_google', 11:12:09 INFO - 'tp6_youtube', 11:12:09 INFO - 'tp6_amazon', 11:12:09 INFO - 'tp6_facebook']}, 11:12:09 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:09 INFO - 'talos_options': ['--stylo', 11:12:09 INFO - '--mitmproxy', 11:12:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:09 INFO - '--firstNonBlankPaint'], 11:12:09 INFO - 'tests': ['tp6_google', 11:12:09 INFO - 'tp6_youtube', 11:12:09 INFO - 'tp6_amazon', 11:12:09 INFO - 'tp6_facebook']}, 11:12:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:09 INFO - 'talos_options': ['--stylo', 11:12:09 INFO - '--stylo-threads=1', 11:12:09 INFO - '--mitmproxy', 11:12:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:09 INFO - '--firstNonBlankPaint'], 11:12:09 INFO - 'tests': ['tp6_google', 11:12:09 INFO - 'tp6_youtube', 11:12:09 INFO - 'tp6_amazon', 11:12:09 INFO - 'tp6_facebook']}, 11:12:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'talos_options': ['--xperf_path', 11:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:09 INFO - 'tests': ['tp5n']}, 11:12:09 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:12:09 INFO - 'talos_options': ['--stylo', 11:12:09 INFO - '--xperf_path', 11:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:09 INFO - 'tests': ['tp5n']}}} 11:12:09 INFO - Running post-action listener: _resource_record_post_action 11:12:09 INFO - [mozharness: 2017-08-29 18:12:09.851060Z] Finished populate-webroot step (success) 11:12:09 INFO - [mozharness: 2017-08-29 18:12:09.851164Z] Running create-virtualenv step. 11:12:09 INFO - Running pre-action listener: _resource_record_pre_action 11:12:09 INFO - Running main action method: create_virtualenv 11:12:09 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:09 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:12:09 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:12:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:12:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:10 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:10 INFO - Installing pip...............done. 11:12:10 INFO - Return code: 0 11:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:12:10 INFO - Reading from file tmpfile_stdout 11:12:10 INFO - Output received: 11:12:10 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:12:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:10 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')]} 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 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')]} 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 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 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:10 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 11:12:10 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 11:12:10 INFO - Using env: {'DISPLAY': ':0', 11:12:10 INFO - 'HOME': '/home/cltbld', 11:12:10 INFO - 'LANG': 'en_US.UTF-8', 11:12:10 INFO - 'LANGUAGE': 'en_US:en', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MAIL': '/var/mail/cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SHLVL': '1', 11:12:10 INFO - 'TERM': 'linux', 11:12:10 INFO - 'TMOUT': '86400', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - '_': '/tools/buildbot/bin/python'} 11:12:12 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:12:12 INFO - Downloading/unpacking pip>=1.5 11:12:12 INFO - Running setup.py egg_info for package pip 11:12:12 INFO - warning: no files found matching 'pip/cacert.pem' 11:12:12 INFO - warning: no files found matching '*.html' under directory 'docs' 11:12:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:12:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:12:12 INFO - Installing collected packages: pip 11:12:12 INFO - Found existing installation: pip 1.1 11:12:12 INFO - Uninstalling pip: 11:12:12 INFO - Successfully uninstalled pip 11:12:12 INFO - Running setup.py install for pip 11:12:12 INFO - warning: no files found matching 'pip/cacert.pem' 11:12:12 INFO - warning: no files found matching '*.html' under directory 'docs' 11:12:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:12:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:12:12 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:12:12 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:12:12 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:12:12 INFO - Successfully installed pip 11:12:12 INFO - Cleaning up... 11:12:12 INFO - Return code: 0 11:12:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12:12 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')]} 11:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:12 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')]} 11:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:12 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 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:12 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 11:12:12 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 11:12:12 INFO - Using env: {'DISPLAY': ':0', 11:12:12 INFO - 'HOME': '/home/cltbld', 11:12:12 INFO - 'LANG': 'en_US.UTF-8', 11:12:12 INFO - 'LANGUAGE': 'en_US:en', 11:12:12 INFO - 'LOGNAME': 'cltbld', 11:12:12 INFO - 'MAIL': '/var/mail/cltbld', 11:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:12 INFO - 'MOZ_NO_REMOTE': '1', 11:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:12 INFO - 'NO_EM_RESTART': '1', 11:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:12 INFO - 'PWD': '/builds/slave/test', 11:12:12 INFO - 'SHELL': '/bin/bash', 11:12:12 INFO - 'SHLVL': '1', 11:12:12 INFO - 'TERM': 'linux', 11:12:12 INFO - 'TMOUT': '86400', 11:12:12 INFO - 'USER': 'cltbld', 11:12:12 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:12 INFO - '_': '/tools/buildbot/bin/python'} 11:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:12 INFO - Downloading/unpacking psutil>=3.1.1 11:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:13 INFO - Installing collected packages: psutil 11:12:13 INFO - Running setup.py install for psutil 11:12:13 INFO - building 'psutil._psutil_linux' extension 11:12:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:12:13 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 11:12:13 INFO - building 'psutil._psutil_posix' extension 11:12:13 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 11:12:13 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 11:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:13 INFO - Successfully installed psutil 11:12:13 INFO - Cleaning up... 11:12:14 INFO - Return code: 0 11:12:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:12:14 INFO - Using env: {'DISPLAY': ':0', 11:12:14 INFO - 'HOME': '/home/cltbld', 11:12:14 INFO - 'LANG': 'en_US.UTF-8', 11:12:14 INFO - 'LANGUAGE': 'en_US:en', 11:12:14 INFO - 'LOGNAME': 'cltbld', 11:12:14 INFO - 'MAIL': '/var/mail/cltbld', 11:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:14 INFO - 'MOZ_NO_REMOTE': '1', 11:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:14 INFO - 'NO_EM_RESTART': '1', 11:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:14 INFO - 'PWD': '/builds/slave/test', 11:12:14 INFO - 'SHELL': '/bin/bash', 11:12:14 INFO - 'SHLVL': '1', 11:12:14 INFO - 'TERM': 'linux', 11:12:14 INFO - 'TMOUT': '86400', 11:12:14 INFO - 'USER': 'cltbld', 11:12:14 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:14 INFO - '_': '/tools/buildbot/bin/python'} 11:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12:14 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 11:12:14 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 11:12:14 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 11:12:14 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 11:12:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:15 INFO - Installing collected packages: mozsystemmonitor 11:12:15 INFO - Running setup.py install for mozsystemmonitor 11:12:15 INFO - Successfully installed mozsystemmonitor 11:12:15 INFO - Cleaning up... 11:12:15 INFO - Return code: 0 11:12:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:15 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')]} 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:15 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')]} 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:15 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 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:15 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 11:12:15 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 11:12:15 INFO - Using env: {'DISPLAY': ':0', 11:12:15 INFO - 'HOME': '/home/cltbld', 11:12:15 INFO - 'LANG': 'en_US.UTF-8', 11:12:15 INFO - 'LANGUAGE': 'en_US:en', 11:12:15 INFO - 'LOGNAME': 'cltbld', 11:12:15 INFO - 'MAIL': '/var/mail/cltbld', 11:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:15 INFO - 'MOZ_NO_REMOTE': '1', 11:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:15 INFO - 'NO_EM_RESTART': '1', 11:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:15 INFO - 'PWD': '/builds/slave/test', 11:12:15 INFO - 'SHELL': '/bin/bash', 11:12:15 INFO - 'SHLVL': '1', 11:12:15 INFO - 'TERM': 'linux', 11:12:15 INFO - 'TMOUT': '86400', 11:12:15 INFO - 'USER': 'cltbld', 11:12:15 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:15 INFO - '_': '/tools/buildbot/bin/python'} 11:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:15 INFO - Downloading/unpacking jsonschema==2.5.1 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:17 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:17 INFO - warning: no files found matching '*.txt' 11:12:17 INFO - no previously-included directories found matching 'build' 11:12:17 INFO - no previously-included directories found matching 'dist' 11:12:17 INFO - no previously-included directories found matching '.git*' 11:12:17 INFO - Installing collected packages: jsonschema, functools32 11:12:17 INFO - Running setup.py install for functools32 11:12:17 INFO - warning: no files found matching '*.txt' 11:12:17 INFO - no previously-included directories found matching 'build' 11:12:17 INFO - no previously-included directories found matching 'dist' 11:12:17 INFO - no previously-included directories found matching '.git*' 11:12:17 INFO - Successfully installed jsonschema functools32 11:12:17 INFO - Cleaning up... 11:12:17 INFO - Return code: 0 11:12:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:12:17 INFO - Using env: {'DISPLAY': ':0', 11:12:17 INFO - 'HOME': '/home/cltbld', 11:12:17 INFO - 'LANG': 'en_US.UTF-8', 11:12:17 INFO - 'LANGUAGE': 'en_US:en', 11:12:17 INFO - 'LOGNAME': 'cltbld', 11:12:17 INFO - 'MAIL': '/var/mail/cltbld', 11:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:17 INFO - 'MOZ_NO_REMOTE': '1', 11:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:17 INFO - 'NO_EM_RESTART': '1', 11:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:17 INFO - 'PWD': '/builds/slave/test', 11:12:17 INFO - 'SHELL': '/bin/bash', 11:12:17 INFO - 'SHLVL': '1', 11:12:17 INFO - 'TERM': 'linux', 11:12:17 INFO - 'TMOUT': '86400', 11:12:17 INFO - 'USER': 'cltbld', 11:12:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:17 INFO - '_': '/tools/buildbot/bin/python'} 11:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:17 INFO - Cleaning up... 11:12:17 INFO - Return code: 0 11:12:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:12:17 INFO - Using env: {'DISPLAY': ':0', 11:12:17 INFO - 'HOME': '/home/cltbld', 11:12:17 INFO - 'LANG': 'en_US.UTF-8', 11:12:17 INFO - 'LANGUAGE': 'en_US:en', 11:12:17 INFO - 'LOGNAME': 'cltbld', 11:12:17 INFO - 'MAIL': '/var/mail/cltbld', 11:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:17 INFO - 'MOZ_NO_REMOTE': '1', 11:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:17 INFO - 'NO_EM_RESTART': '1', 11:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:17 INFO - 'PWD': '/builds/slave/test', 11:12:17 INFO - 'SHELL': '/bin/bash', 11:12:17 INFO - 'SHLVL': '1', 11:12:17 INFO - 'TERM': 'linux', 11:12:17 INFO - 'TMOUT': '86400', 11:12:17 INFO - 'USER': 'cltbld', 11:12:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:17 INFO - '_': '/tools/buildbot/bin/python'} 11:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:17 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:18 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:19 INFO - Downloading docopt-0.6.1.tar.gz 11:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:19 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:19 INFO - Running setup.py install for blobuploader 11:12:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:19 INFO - Running setup.py install for requests 11:12:19 INFO - Running setup.py install for docopt 11:12:19 INFO - Successfully installed blobuploader requests docopt 11:12:19 INFO - Cleaning up... 11:12:20 INFO - Return code: 0 11:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:20 INFO - Using env: {'DISPLAY': ':0', 11:12:20 INFO - 'HOME': '/home/cltbld', 11:12:20 INFO - 'LANG': 'en_US.UTF-8', 11:12:20 INFO - 'LANGUAGE': 'en_US:en', 11:12:20 INFO - 'LOGNAME': 'cltbld', 11:12:20 INFO - 'MAIL': '/var/mail/cltbld', 11:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:20 INFO - 'MOZ_NO_REMOTE': '1', 11:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:20 INFO - 'NO_EM_RESTART': '1', 11:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:20 INFO - 'PWD': '/builds/slave/test', 11:12:20 INFO - 'SHELL': '/bin/bash', 11:12:20 INFO - 'SHLVL': '1', 11:12:20 INFO - 'TERM': 'linux', 11:12:20 INFO - 'TMOUT': '86400', 11:12:20 INFO - 'USER': 'cltbld', 11:12:20 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:20 INFO - '_': '/tools/buildbot/bin/python'} 11:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:20 INFO - Running setup.py (path:/tmp/pip-3_IHGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:20 INFO - Running setup.py (path:/tmp/pip-wwVSjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:20 INFO - Running setup.py (path:/tmp/pip-08ZGiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:20 INFO - Running setup.py (path:/tmp/pip-r1ASMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:20 INFO - Running setup.py (path:/tmp/pip-72x1os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:20 INFO - Running setup.py (path:/tmp/pip-q_84J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:20 INFO - Running setup.py (path:/tmp/pip-7Rte8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:20 INFO - Running setup.py (path:/tmp/pip-czpIAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:20 INFO - Running setup.py (path:/tmp/pip-sIYCKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:20 INFO - Running setup.py (path:/tmp/pip-IC8fF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:20 INFO - Running setup.py (path:/tmp/pip-nWIlZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:21 INFO - Running setup.py (path:/tmp/pip-mdVihV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:21 INFO - Running setup.py (path:/tmp/pip-VdpFUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:21 INFO - Running setup.py (path:/tmp/pip-Md5_RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:21 INFO - Running setup.py (path:/tmp/pip-C64DJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:21 INFO - Running setup.py (path:/tmp/pip-urClHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:21 INFO - Running setup.py (path:/tmp/pip-XT6816-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:21 INFO - Running setup.py install for manifestparser 11:12:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:21 INFO - Running setup.py install for mozcrash 11:12:21 INFO - Running setup.py install for mozdebug 11:12:21 INFO - Running setup.py install for mozdevice 11:12:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:21 INFO - Running setup.py install for mozfile 11:12:21 INFO - Running setup.py install for mozhttpd 11:12:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Running setup.py install for mozinfo 11:12:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Running setup.py install for mozInstall 11:12:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Running setup.py install for mozleak 11:12:22 INFO - Running setup.py install for mozlog 11:12:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Running setup.py install for moznetwork 11:12:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Running setup.py install for mozprocess 11:12:22 INFO - Running setup.py install for mozprofile 11:12:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Running setup.py install for mozrunner 11:12:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Running setup.py install for mozscreenshot 11:12:22 INFO - Running setup.py install for moztest 11:12:23 INFO - Running setup.py install for mozversion 11:12:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:23 INFO - Cleaning up... 11:12:23 INFO - Return code: 0 11:12:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:23 INFO - Using env: {'DISPLAY': ':0', 11:12:23 INFO - 'HOME': '/home/cltbld', 11:12:23 INFO - 'LANG': 'en_US.UTF-8', 11:12:23 INFO - 'LANGUAGE': 'en_US:en', 11:12:23 INFO - 'LOGNAME': 'cltbld', 11:12:23 INFO - 'MAIL': '/var/mail/cltbld', 11:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:23 INFO - 'MOZ_NO_REMOTE': '1', 11:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:23 INFO - 'NO_EM_RESTART': '1', 11:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:23 INFO - 'PWD': '/builds/slave/test', 11:12:23 INFO - 'SHELL': '/bin/bash', 11:12:23 INFO - 'SHLVL': '1', 11:12:23 INFO - 'TERM': 'linux', 11:12:23 INFO - 'TMOUT': '86400', 11:12:23 INFO - 'USER': 'cltbld', 11:12:23 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:23 INFO - '_': '/tools/buildbot/bin/python'} 11:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:23 INFO - Running setup.py (path:/tmp/pip-92hpl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:23 INFO - Running setup.py (path:/tmp/pip-90HKxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:23 INFO - Running setup.py (path:/tmp/pip-GxqZd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:23 INFO - Running setup.py (path:/tmp/pip-XHcR26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:23 INFO - Running setup.py (path:/tmp/pip-Xc0geV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:23 INFO - Running setup.py (path:/tmp/pip-TuYbAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:23 INFO - Running setup.py (path:/tmp/pip-mSmnTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:23 INFO - Running setup.py (path:/tmp/pip-9Pd2qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:23 INFO - Running setup.py (path:/tmp/pip-iaLGwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:24 INFO - Running setup.py (path:/tmp/pip-dLzx3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:24 INFO - Running setup.py (path:/tmp/pip-w5HxCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:24 INFO - Running setup.py (path:/tmp/pip-0XF0_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:24 INFO - Running setup.py (path:/tmp/pip-6v4gqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:24 INFO - Running setup.py (path:/tmp/pip-hQ18OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:24 INFO - Running setup.py (path:/tmp/pip-q_A60z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:24 INFO - Running setup.py (path:/tmp/pip-g6Q5wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:24 INFO - Running setup.py (path:/tmp/pip-2JlvpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:12:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:25 INFO - Downloading blessings-1.6.tar.gz 11:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:25 INFO - Installing collected packages: blessings 11:12:25 INFO - Running setup.py install for blessings 11:12:25 INFO - Successfully installed blessings 11:12:25 INFO - Cleaning up... 11:12:25 INFO - Return code: 0 11:12:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:26 INFO - Reading from file tmpfile_stdout 11:12:26 INFO - Current package versions: 11:12:26 INFO - argparse == 1.2.1 11:12:26 INFO - blessings == 1.6 11:12:26 INFO - blobuploader == 1.2.4 11:12:26 INFO - docopt == 0.6.1 11:12:26 INFO - functools32 == 3.2.3-2 11:12:26 INFO - jsonschema == 2.5.1 11:12:26 INFO - manifestparser == 1.1 11:12:26 INFO - mozInstall == 1.13 11:12:26 INFO - mozcrash == 1.0 11:12:26 INFO - mozdebug == 0.1 11:12:26 INFO - mozdevice == 0.51 11:12:26 INFO - mozfile == 1.2 11:12:26 INFO - mozhttpd == 0.7 11:12:26 INFO - mozinfo == 0.10 11:12:26 INFO - mozleak == 0.1 11:12:26 INFO - mozlog == 3.5 11:12:26 INFO - moznetwork == 0.27 11:12:26 INFO - mozprocess == 0.25 11:12:26 INFO - mozprofile == 0.28 11:12:26 INFO - mozrunner == 6.13 11:12:26 INFO - mozscreenshot == 0.1 11:12:26 INFO - mozsystemmonitor == 0.3 11:12:26 INFO - moztest == 0.8 11:12:26 INFO - mozversion == 1.4 11:12:26 INFO - psutil == 3.1.1 11:12:26 INFO - requests == 1.2.3 11:12:26 INFO - wsgiref == 0.1.2 11:12:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:26 INFO - Using env: {'DISPLAY': ':0', 11:12:26 INFO - 'HOME': '/home/cltbld', 11:12:26 INFO - 'LANG': 'en_US.UTF-8', 11:12:26 INFO - 'LANGUAGE': 'en_US:en', 11:12:26 INFO - 'LOGNAME': 'cltbld', 11:12:26 INFO - 'MAIL': '/var/mail/cltbld', 11:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:26 INFO - 'MOZ_NO_REMOTE': '1', 11:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:26 INFO - 'NO_EM_RESTART': '1', 11:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:26 INFO - 'PWD': '/builds/slave/test', 11:12:26 INFO - 'SHELL': '/bin/bash', 11:12:26 INFO - 'SHLVL': '1', 11:12:26 INFO - 'TERM': 'linux', 11:12:26 INFO - 'TMOUT': '86400', 11:12:26 INFO - 'USER': 'cltbld', 11:12:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:26 INFO - '_': '/tools/buildbot/bin/python'} 11:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 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)) 11:12:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:12: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 11:12: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 11:12: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 11:12: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 11:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:12:27 INFO - Installing collected packages: simplejson 11:12:27 INFO - Running setup.py install for simplejson 11:12:27 INFO - building 'simplejson._speedups' extension 11:12:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:12:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:12:28 INFO - Successfully installed simplejson 11:12:28 INFO - Cleaning up... 11:12:28 INFO - Return code: 0 11:12:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:28 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')]} 11:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:28 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')]} 11:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:28 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 0xb241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, '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-1504027759.962957-1839089101', '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 11:12:28 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 11:12:28 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 11:12:28 INFO - Using env: {'DISPLAY': ':0', 11:12:28 INFO - 'HOME': '/home/cltbld', 11:12:28 INFO - 'LANG': 'en_US.UTF-8', 11:12:28 INFO - 'LANGUAGE': 'en_US:en', 11:12:28 INFO - 'LOGNAME': 'cltbld', 11:12:28 INFO - 'MAIL': '/var/mail/cltbld', 11:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:28 INFO - 'MOZ_NO_REMOTE': '1', 11:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:28 INFO - 'NO_EM_RESTART': '1', 11:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:28 INFO - 'PWD': '/builds/slave/test', 11:12:28 INFO - 'SHELL': '/bin/bash', 11:12:28 INFO - 'SHLVL': '1', 11:12:28 INFO - 'TERM': 'linux', 11:12:28 INFO - 'TMOUT': '86400', 11:12:28 INFO - 'USER': 'cltbld', 11:12:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:28 INFO - '_': '/tools/buildbot/bin/python'} 11:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:12:28 INFO - Cleaning up... 11:12:28 INFO - Return code: 0 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - Running post-action listener: _start_resource_monitoring 11:12:28 INFO - Starting resource monitoring. 11:12:28 INFO - [mozharness: 2017-08-29 18:12:28.855172Z] Finished create-virtualenv step (success) 11:12:28 INFO - [mozharness: 2017-08-29 18:12:28.855693Z] Running install step. 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: install 11:12:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:29 INFO - Reading from file tmpfile_stdout 11:12:29 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:29 INFO - Reading from file tmpfile_stdout 11:12:29 INFO - Output received: 11:12:29 INFO - Usage: mozinstall [options] installer 11:12:29 INFO - Options: 11:12:29 INFO - -h, --help show this help message and exit 11:12:29 INFO - -d DEST, --destination=DEST 11:12:29 INFO - Directory to install application into. [default: 11:12:29 INFO - "/builds/slave/test"] 11:12:29 INFO - --app=APP Application being installed. [default: firefox] 11:12:29 INFO - mkdir: /builds/slave/test/build/application 11:12:29 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'] 11:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:12:47 INFO - Reading from file tmpfile_stdout 11:12:47 INFO - Output received: 11:12:47 INFO - /builds/slave/test/build/application/firefox/firefox 11:12:47 INFO - Running post-action listener: _resource_record_post_action 11:12:47 INFO - [mozharness: 2017-08-29 18:12:47.126255Z] Finished install step (success) 11:12:47 INFO - [mozharness: 2017-08-29 18:12:47.126655Z] Running setup-mitmproxy step. 11:12:47 INFO - Running pre-action listener: _resource_record_pre_action 11:12:47 INFO - Running main action method: setup_mitmproxy 11:12:47 INFO - Skipping: mitmproxy is not required 11:12:47 INFO - Running post-action listener: _resource_record_post_action 11:12:47 INFO - [mozharness: 2017-08-29 18:12:47.128257Z] Finished setup-mitmproxy step (success) 11:12:47 INFO - [mozharness: 2017-08-29 18:12:47.128570Z] Running run-tests step. 11:12:47 INFO - Running pre-action listener: _resource_record_pre_action 11:12:47 INFO - Running pre-action listener: _set_gcov_prefix 11:12:47 INFO - Running main action method: run_tests 11:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:47 INFO - Python 2.7.3 11:12:47 INFO - Return code: 0 11:12:47 INFO - grabbing minidump binary from tooltool 11:12:47 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')]} 11:12:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0xe90130>, '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 0xe91030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe914c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:12:47 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:12:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:12:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:47 INFO - Return code: 0 11:12:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:12:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:47 INFO - ENV: RUST_BACKTRACE is now full 11:12:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:12:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:47 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/J1Wwa5wdSOSum0rQh28Tpg/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 11:12:47 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/J1Wwa5wdSOSum0rQh28Tpg/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 11:12:47 INFO - Using env: {'DISPLAY': ':0', 11:12:47 INFO - 'HOME': '/home/cltbld', 11:12:47 INFO - 'LANG': 'en_US.UTF-8', 11:12:47 INFO - 'LANGUAGE': 'en_US:en', 11:12:47 INFO - 'LOGNAME': 'cltbld', 11:12:47 INFO - 'MAIL': '/var/mail/cltbld', 11:12:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:47 INFO - 'MOZ_NO_REMOTE': '1', 11:12:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:47 INFO - 'NO_EM_RESTART': '1', 11:12:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:47 INFO - 'PWD': '/builds/slave/test', 11:12:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:47 INFO - 'RUST_BACKTRACE': 'full', 11:12:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:12:47 INFO - 'SHELL': '/bin/bash', 11:12:47 INFO - 'SHLVL': '1', 11:12:47 INFO - 'TERM': 'linux', 11:12:47 INFO - 'TMOUT': '86400', 11:12:47 INFO - 'USER': 'cltbld', 11:12:47 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:47 INFO - '_': '/tools/buildbot/bin/python'} 11:12:47 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/J1Wwa5wdSOSum0rQh28Tpg/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 11:12:47 INFO - mozversion application_buildid: 20170829172659 11:12:47 INFO - mozversion application_changeset: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 11:12:47 INFO - mozversion application_display_name: Nightly 11:12:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:47 INFO - mozversion application_name: Firefox 11:12:47 INFO - mozversion application_remotingname: firefox 11:12:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:12:47 INFO - mozversion application_vendor: Mozilla 11:12:47 INFO - mozversion application_version: 57.0a1 11:12:47 INFO - mozversion platform_buildid: 20170829172659 11:12:47 INFO - mozversion platform_changeset: e336d84fc1d2d1fde7387dd5f86fe06fa59abe10 11:12:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:12:47 INFO - mozversion platform_version: 57.0a1 11:12:47 INFO - using testdate: 1504030367 11:12:47 INFO - actual date: 1504030367 11:12:47 INFO - starting webserver on 'localhost:40039' 11:12:47 INFO - SUITE-START | Running 2 tests 11:12:47 INFO - TEST-START | dromaeo_css 11:12:47 INFO - Initialising browser for dromaeo_css test... 11:12:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40039/getInfo.html -profile /tmp/tmpwg6sHa/profile 11:12:47 INFO - TEST-INFO | started process 15786 (/builds/slave/test/build/application/firefox/firefox http://localhost:40039/getInfo.html) 11:12:53 INFO - TEST-INFO | 15786: exit 0 11:12:54 INFO - Browser initialized. 11:12:54 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:54 INFO - Using env: {'DISPLAY': ':0', 11:12:54 INFO - 'HOME': '/home/cltbld', 11:12:54 INFO - 'JSGC_DISABLE_POISONING': '1', 11:12:54 INFO - 'LANG': 'en_US.UTF-8', 11:12:54 INFO - 'LANGUAGE': 'en_US:en', 11:12:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:12:54 INFO - 'LOGNAME': 'cltbld', 11:12:54 INFO - 'MAIL': '/var/mail/cltbld', 11:12:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:54 INFO - 'MOZ_CRASHREPORTER': '1', 11:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:12:54 INFO - 'MOZ_NO_REMOTE': '1', 11:12:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:54 INFO - 'NO_EM_RESTART': '1', 11:12:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:54 INFO - 'PWD': '/builds/slave/test', 11:12:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:54 INFO - 'RUST_BACKTRACE': 'full', 11:12:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:12:54 INFO - 'SHELL': '/bin/bash', 11:12:54 INFO - 'SHLVL': '1', 11:12:54 INFO - 'TERM': 'linux', 11:12:54 INFO - 'TMOUT': '86400', 11:12:54 INFO - 'USER': 'cltbld', 11:12:54 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:54 INFO - '_': '/tools/buildbot/bin/python'} 11:12:54 INFO - TEST-INFO | started process 15958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwg6sHa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:54 INFO - PID 15958 | 11:12:54 INFO - PID 15958 | (/builds/slave/test/build/application/firefox/firefox:16008): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:12:54 INFO - PID 15958 | 11:13:05 INFO - PID 15958 | RSS: Main: 170217472 11:13:05 INFO - PID 15958 | 11:16:04 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:40039/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40039/tests/dromaeo/cssquery-ext.html) 11:16:05 INFO - PID 15958 | RSS: Main: 171560960 11:16:05 INFO - PID 15958 | 11:19:07 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:40039/tests/dromaeo/cssquery-ext.html (next: http://localhost:40039/tests/dromaeo/cssquery-jquery.html) 11:19:07 INFO - PID 15958 | RSS: Main: 170094592 11:19:07 INFO - PID 15958 | 11:22:09 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:40039/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40039/tests/dromaeo/cssquery-mootools.html) 11:22:10 INFO - PID 15958 | RSS: Main: 172277760 11:22:10 INFO - PID 15958 | 11:25:11 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:40039/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40039/tests/dromaeo/cssquery-prototype.html) 11:25:12 INFO - PID 15958 | RSS: Main: 170500096 11:25:12 INFO - PID 15958 | 11:28:16 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:40039/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40039/tests/dromaeo/cssquery-yui.html) 11:28:16 INFO - PID 15958 | RSS: Main: 172650496 11:28:16 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:40039/tests/dromaeo/cssquery-yui.html (next: http://localhost:40039/tests/dromaeo/cssquery-dojo.html) 11:31:18 INFO - PID 15958 | RSS: Main: 174858240 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | __start_tp_report 11:31:18 INFO - PID 15958 | _x_x_mozilla_page_load 11:31:18 INFO - PID 15958 | _x_x_mozilla_page_load_details 11:31:18 INFO - PID 15958 | |i|pagename|runs| 11:31:18 INFO - PID 15958 | |0;dojo.html;3301.884434044809;3315.1049216711485;3337.649546797587;3345.6487068857787;3374.780639258448;6187.164732761076;6226.4084911933405;6238.251409830821;6286.497080233582;6374.490040796737;6292.905606415896;6366.236051673805;6384.138141350916;6404.6797660117045;6408.519361047916;5762.942370576304;5813.73838177281;5831.854203644922;5874.911876321838;5876.08920617305;5638.323401191863;5703.686297253649;5723.2559767230205;5770.538356931456;5796.594238403313;5704.971475142618;5785.508231800302;5793.681347525884;5826.329972053205;5832.825015249549;5714.685692286923;5742.942570574282;5754.6547207167705;5764.250647415851;5795.478406943395;5529.253550770675;5649.23735295734;5708.686022268774;5731.168980497804;5746.109353050284;6186.597871138407;6227.96886015567;6235.407636274546;6275.403836635558;6276.278228003793;6689.6989635466525;6693.497987650897;6761;6772.356626120511;6783.6269005204695;6640.7343706251695;6733;6744.696488658022;6841.144856892888;6845.520813543004;6254.030625253093;6266.905996410058;6275.560710750249;6278.6546739929745;6279.089532017878;6889.0355350251;6905.1713794344;6970.024196612479;6972.6862291196;6995.300469952964;6511.251206111263;6542.378474044958;6590.143281373486;6606.7026983785845;6618.139641846626;6693.263740988487;6710.1947766267385;6710.731570737214;6712.865742685119;6713.69788359525;6616.371444712745;6620.073189753439;6622.2715501294815;6630.138082049302;6640.037194606755;6648.235452922879;6652.101966234593;6653.401193892573;6678.465722742169;6687.097241872382;4906.656534042654;4907.1657818171;4959.330490383824;4959.702417854868;4975;4324.675649326313;4333.155034768253;4341.869743907688;4379.912401752011;4398.076403955141;5817;5879.029960056543;5889.204957330706;5891.322497912709;5894.6757928314355;6741.1910570731825;6777.6272305023695;6784.93215067843;6798.04827324175;6829.180498340231;5827.912581311284;5838.649681019152;5919.792807251725;5928.258967629046;5929.703514824328;5625.212470254168;5746.080627099644;5750.769969201185;5826.184334193216;5826.504747096459;6486.513511486657;6488.416042556192;6545.705443255065;6549.377809108032;6580.177477815273;6735.898961515483;6769.289224631343;6809.250982392032;6820.965895170492;6821.795346139425;6476.740930362733;6478.28738838718;6517.8696426072165;6580.473562114924;6588.637624930483;6567.540272180901;6617.735290588323;6626.933730662631;6641.501887358564;6736.191657001191;6716.899246511404;6736.427403670743;6772.0857684212;6774.491913106635;6790.694418751069;6371.522135839923;6450.516211284079;6542.051402546509;6557.082008518716;6559.704813283509;6386.872262554816;6439.774607888701;6462.612243265231;6533.248676402084;6539.70571324282;6404.551681382259;6434.420902118832;6470.935290647221;6499.252585952676;6527.771527996498;6530.249021362604;6566.146400967844;6586.50601204902;6603.438707709898;6632.071509988509;6174.197354343906;6271.843203919939;6298.1812364392335;6312.495000400048;6313.652749098844 11:31:18 INFO - PID 15958 | |1;ext.html;792.2592376128321;835.3609488741114;872.1932212703252;875;1106.4578356605266;28236.435271294562;29077;39088;40083.39874901879;40101.598984010154;39798.40302395466;40113.19773604533;40138.59861401392;40140.799296003555;40179;7258.564486130849;7644.5031072980355;7851.254130857588;7858.528488290693;7870.370370370357;7656.846863062736;7759.6120193990355;7760.922390776104;7761.650725717356;7762.068551773795;7743.806404839896;7790.337821285198;7792.103908050562;7807.414443916729;7812.414068944823;7750.922490775077;7779.416543759241;7781.766547003599;7791.961040194791;7792.220777922247;7704.075510938667;7726.188750181263;7741.961290193569;7746.41901857363;7748.302652761278;36007.4598881017;36095;36138.277234455425;36139.4579081314;36189.81905090484;3481.0601137692934;3507.2985402919517;3510.8771193008124;3519.419295816187;3519.9472007919644;29479.557806632918;29695.40609187804;29695.70304296951;29718.851405742833;29754.70245297541;5081.466446023152;5087.26234695967;5090.541851233407;5134.563562097189;5168.431472538018;180218;183281;183439;184060;184415;44580.108397831864;45036.3244551332;45122;45156;45246.54753452489;46730.76634616805;46858.29712554315;46994.53005469902;47071.29393059107;47095.29357059647;12856.807147892789;15065.17141557225;15073.849261507465;15350;15409.845901541064;10621.362718236776;11668.124890633237;11926.88073119275;11956.402179891145;11959;13711.725765484634;13727.245001524812;13760.17438953666;13828;13834.792478112837;5540.722963851791;5603.187537806995;5606.6636001840025;5621.297337832771;5675.801346952837;974.4932635029745;1005.4922264256504;1006.1146191351564;1011.2971484817981;1014.2747935226201;22110.889445552668;22446.551068978857;22485.32544023682;22694.546109077724;22754.886225568767;1100.1913593508764;1105.1876870500175;1106.0653747583278;1110.9944450277696;1114.4594871487323;11670.70823229426;11904.821253196782;12006.039516838631;12013.159078864395;15111.54665360041;238765;239728;240727;240968;241311;53087.203691944655;53768.462315376346;53798;53861;53899.73050134724;1385.12044851518;1413.5971248194421;1416.5608661314818;1425.6934759026858;1435.3756116089326;26182.60726089072;26351.20946371612;26720.19839404821;26722.59916101221;26751.197464076107;36147.27705445929;36466.63533364632;36488.45267321046;36514.26971460609;36559;200353;200703;200740;202097;202633;31573.8421307892;31806;35773.64226357703;36662;36738.63261367352;42613.786931065144;43809;43875;44370.334444982705;44426.11147776962;32112.518312224867;32687.67312326846;32750.836245818617;33091.172720681214;33144.83427582846;31744.04767856968;32740;32799.180020499676;33335.33329333448;33433.665663343054;36730.26539469142;37203.62796372001;37366.252674946896;37476.62523374731;37568.81215593904;31512;32052.67947320497;32082.679173208904;32112.197195070312;32736.50895236621;23304.533909322057;23575.64636530419;23962.28113156608;24047.158349457684;24395.75604243935 11:31:18 INFO - PID 15958 | |2;jquery.html;544.6269305525715;553.6843998920617;565.6577770448876;568.2016766443148;573.5669569475047;21274;21945.34163975081;21977.450563735896;21979.340619781433;22105.447363815914;24776;25099.121530746426;25126.623100653505;25170.49659006819;25244.621330680053;6628.972509261072;6771.424428923548;6774.356436138559;6774.661266936633;6799.76200832971;6351.428371446569;6552.770653027121;6883.6558172091445;6946.47901407394;6953.269906659803;6933.965330173367;6957.860842783141;6958.304169583052;6961.547499412522;6961.825954351131;6913.20498142715;6914.550554213985;6924.23833378328;6926.584404935695;6930.13373328334;6742.2246441659345;6764.797056088325;6777.62723050232;6789.558678685869;6791.830204244884;29712.257193570116;30803.84598076995;31780.841095794603;31871.52192717111;31945.201369965936;2131.456478597948;2178.5425060737266;2182.8253739700785;2189.27753841232;2189.693442917993;19853.702194467096;20797.37607871766;20807.271745488986;20815.791842081537;20875.79124208769;2502.949941001188;2524.8106392020673;2587.3143616941525;2595.7923366130663;2598.233521111277;137955.31022344925;144569;144698.55301446957;145564.27217863948;145674.27162864225;21418.464538386666;21952.121915123535;22168.778312216673;22274.777252227595;22436.551268974854;41230;41253.79373103175;41304.586954130675;41365.58634413678;41401.58598414037;11141.108711303077;11251.381174035343;11266.155038372155;11275.943620281847;11282.661520154408;9266.583003764847;9314.068593140631;9319.767005824773;9338.719838404859;9451.243900487945;11511.30932144074;11512.769744605228;11741.530338786524;11808.173427859967;11819.763604727857;4153.979230103831;4203.579642035772;4257.3613957905945;4316.892077698019;4385.3641222022625;947.1049857884371;969.132626299458;976.7948730766476;977.4721650308895;994.9054839790208;18996.715049274273;19041.523961901064;19075.046247687562;19298.22807087701;19541;1000.364768372089;1020.2705065877933;1022.3354819367322;1028.388109075099;1031.2059714020163;10219.540120694586;10455.529501172465;10510.474476276155;10815.67552973412;10839.024487796136;459625;474858;476978;477776;572073;122641;127721;128654;128672;128706.35646821705;1163.6450882480924;1212.1999480342754;1214.1552736784922;1219.4634360881184;1235.0613533714443;20708.48228794232;20928.686069708663;20980.685289720972;21324.89337553302;21349.573008540054;58883;59430;60153.39846601653;60581.39418605934;61871.071933920124;69513.65243173752;70050;70272.29727702658;70547.29452705613;70691;14135.575932722035;14375.137491750529;14608.634784130481;14629;14670.853291466949;22863.428414289112;22876.771232287465;22887.42781430411;22923.083076677412;23145;16227.594310142342;16851.65186785079;16968.236429360957;16993.15034248258;17146.314147433965;16781.832181678026;16821.327146914475;17220.746009230257;17630.294788208328;17664.646707066044;18448.81551184471;19697.606047878675;19705.211791528753;19912.303069392503;19917.800821991594;14395.352209150404;14614.707705846036;14622.853771462149;14638;14654.19401932904;17998.5500362492;18348.357807476674;18455.723164152816;18753.812461875208;18778.248870045045 11:31:18 INFO - PID 15958 | |3;mootools.html;1319.3732976836002;1387.2162228340987;1394.177435313165;1404.4663028049347;1404.8314202295724;12541.247525148498;14507.202103884281;15209.923950380247;15213.923930380346;15229.771553426708;12626.684332891682;14643.63390915225;15179.848201518009;15182.164980926073;15185.696286074271;2556.3736884463287;2609.5302845487804;2611.4777044591065;2612.255507180454;2612.399148195916;2622.55416579182;2839.318563544755;2842.6588809342907;2842.7015163407855;2863.3557449573887;2708.5530887403556;2735.3161709572605;2742.0951086141627;2779.5691667791525;2790.2047916343745;2619.1749598876295;2619.4891996060774;2641.022821556027;2641.432092100198;2646.1400044985457;2632.065616706061;2643.814932954694;2654.283343497264;2656.800739944512;2657.720939301365;14340.498082567165;14635.780463293058;14675.77986330206;14677.339519721638;14690.192039437827;7778.844423111563;8000.479968802009;8039.678412863478;8061;8069.031716194036;5389.191621256804;5551.084071128259;5558.471945165203;5703.0589952657765;5762.423757624204;1930.536671198916;1932.9710054349196;1939.660559402113;1970.6058788242265;1974.3089918528544;24566;24639.753602463927;24676.753232467625;24733.876330618412;24784.38039049002;6333.20834895638;6343.682815859189;6614.173228346457;6641.501887358468;6758.324167583202;16225.188740562924;16261.349546018264;16281;16304;16311.42909998168;7552.66013029415;7826.530408175528;7826.8434631307055;7828.334591559781;7833.451658383859;7137.10786151731;7186.784396468114;7206.207317195104;7251.56490610565;7263.89104163438;4686.882827929329;4867.367242258484;4882.511748825089;4905.754712264373;5011.248312753043;1323.7418703352946;1342.2215115233141;1349.0556610372778;1361.5438827992534;1364.7134101838526;871.0679572857109;890.0698769785589;899.1008991008991;904.791897863482;907.5507623726297;7464.440166987498;7514.849703005909;7525.360344370681;7546;7575.848483030309;720.621673621353;731.4587205468022;979.2655508368723;1012.2357619996856;1015.720676813882;5044.974775126101;5098.388193416814;5107.565856902205;5220.634555581073;5239.711815850089;20470.38588842337;20872.79127208739;21090.156393744386;21406.785932140792;21420.357389278033;19546.413607591796;20779.376618701463;20780.27269045576;20847.583048338947;20899.268525601532;10958.945205274082;11169.162312826571;11188.552457901755;11192.552297907992;11212.383318917375;8087.63605637736;8148.6962086068315;8226.095129535626;8305.667773289;8349.66601335964;17513.737293940856;17874.5531361717;18085.638287234444;18249;18273.3604323848;17668.381606643707;17793.822061779218;17836.3757268495;18096.09519524045;18158.90920545389;11956.103292252941;11971;12186.268823870596;12194;12199.75600488003;13597.252151131783;13642.522511712043;13773.311334433438;13777.517786877412;13786.103903246258;10718.35689858611;10764;10973.177011724312;10988.945055274673;11129.220954533104;10806.729831753955;10812.567497300335;10865.837012444661;11030.172737044593;11071.169662275523;9809.411435313905;9936;9983.850242246517;10073.093421592092;10077.344972576759;7494.475386722877;7555.471117021756;7594.544327340377;7599.544027358376;7666.310032097138;7426.3188660675705;7594.8860767089645;7637.350825179922;7740.612969351622;7770.417218708506 11:31:18 INFO - PID 15958 | |4;prototype.html;497.8921898775226;504.8493418039154;523.5000574451399;526.8656492594392;526.9631125821192;6278.717457714402;6366.262507121935;6368.363163683629;6399.136116624254;6454.967725161374;6071.939280607193;6156.199694039779;6188.907166392508;6241.625502469844;6285.277193122793;4974.204127339626;4986.4514903360605;5001.224565279328;5014;5061.519155680223;4932.630052746041;4995.35060442142;5003.2995380646735;5044.445111037783;5048.419431765357;4832.299316599091;4920.778564964585;4966.726830024347;4972.8508144755715;4987.775550100236;4978.303037574742;4993.925091123636;5014.974925125388;5015.247712843066;5017.5484206421415;4458.242098843172;4459.710118842265;4459.732416055014;4466.129104824528;4470.619997300233;6174;6193.845153871144;6199.690015499252;6208;6211.534134939852;5631.915521267143;5663.0655941769555;5671.943280567183;5698.116791897262;5709.971450142764;6515.315891831337;6534.281229064846;6626.204855417381;6634.237062737799;6666.766663166814;4840.394950631171;4851.490593487668;4864.7324397158145;4865.70805751656;4880.975595122037;6895.896561551581;6917.51577389583;6936.79189624312;6984.685689144001;7014.333638304353;4946.8515944521005;4974.676646017997;5002.699838009731;5031.899362012739;5046.167382381939;5026.39155470246;5063.1645778446145;5069.31564238823;5088.949110508922;5104.617153713486;5662.027435596345;5663.915041274384;5666.801661941812;5720.94046143388;5724.4561766632105;6735.326467353226;6735.8989615155815;6741.561798483083;6754.3921047106;6770.93229067703;1625.8130315013689;1674.7236705943626;1709.3248166973976;1723.7759091318298;1729.9827001730073;1121.545773961547;1176.0474016046858;1205.1744554979866;1213.3144773203112;1220.1398014399826;5696.23100881384;5751.884962300815;5790.681512516768;5825.242718446575;5838.299404071538;6578.243501997236;6584.572002819801;6631.801045968628;6696;6739.764108256188;5725.77096916127;5745.827625171251;5804.129380592861;5812.88374232513;5859.326177489558;3487.5466189395215;3557.008075477741;3567.073780158737;3590.856365745341;3606.6213047630145;6414.61512309263;6422.582532135396;6525.412712855866;6588.637624930579;6605.438537724347;6829;6879.484038697117;6959.007626720559;6964.597213961175;7011.193712723;6467.741290348427;6469.482441404676;6569.80290591283;6620.602763834186;6632.966835165793;6646.435053020354;6734.8653026940165;6767.35710107539;6767.492438067263;6799.524033317818;6651.403663120719;6700.4639628830555;6766.357196066366;6775.593464392152;6796.35434633709;6525.510586706111;6550.543546170186;6572.652606215619;6578.375054369827;6645.833854153685;4936;4940.135476291706;4974.37820272466;4997.200447928314;5003.249512573143;6731.394174524316;6791.898121528082;6798.830029249309;6807.829804254933;6813.420859226823;6409.679516024087;6459.870802583828;6522.380373864476;6568.047633093271;6620.24563490685;6417.016087519326;6418.550701450854;6537.934620653923;6550.410463058348;6599.9010014848855;5985.3015382924195;6532.824091663356;6555.3772391622715;6555.3772391622715;6565.737370505126;6633.2371777246235;6633.834154146185;6660.367265109807;6667.666616669244;6671.365515448746;6217.222847144107;6407.359264073555;6414.198225221848;6427.164468619049;6505.674716264262 11:31:18 INFO - PID 15958 | |5;yui.html;864.1099667342637;882.3911501064265;886.5965985476607;890.2210565754964;896.8027034052515;17266.2230199641;17474.737878931825;17539.38612148575;18037.729434058485;21481.248156314494;20548.794512054876;21335.25326613565;21383.57232855342;21511.892440537813;21598.676019859715;884.4339622641498;903.5346796399859;905.732808821396;905.9320550958671;911.4166933162782;914.6204325205065;946.0633972367375;946.9242460603135;949.8765160529122;951.7192428233653;1003.0721582536162;1006.718118926698;1007;1007.209340667576;1007.3351587951953;1001.099010890201;1005.6731562242264;1006.3358183598826;1006.6023920551341;1006.9496525173786;733.6625152429889;740.1192580828797;740.1894925057107;740.4261697184671;740.6111791309552;18601;18828.717569236473;18968.62062758737;19417.417477475556;19447.3193438229;19973.400797976083;20592.176312947464;20782.168713251453;21149.471263218387;21158.894205529028;16502.33990640373;16741.246643900933;16744.69678063389;16865.831341686673;16886.74669879953;3641.1443310821937;3658.432942893829;3665.3585622515952;3666.0834791302173;3668.926621467556;121849.39075304655;122369.38815305955;123431;128407;129464.35267823694;16604.916975415286;16924;17111.401100961408;17239.82760172382;17342.65314693699;28542.85728571344;30333.544996825065;30365.544516832266;30389.544156837666;30426.695733042387;8645.783855403539;8901.020887702347;8922.464652120894;8923;8937;4037.6769858411258;4124.566920473367;4128.401381799622;4128.525219599785;4146.087860670647;5106.872328191751;5166.405863325691;5201.973990130025;5211.192265198824;5214.191800270964;994.0606127209862;1026.8357062870055;1030.7989941961396;1030.835066389389;1035.9585616575403;640.5196102922808;685.0785693242581;701.1516065560627;710.1974768511652;713.1371041040295;11520.423978801195;11525.308481491138;11649.47577359021;12351.69120771988;12501.874981250254;693.9375456208966;694.1080711285973;695.0963747128712;697.5212549395314;702.0592406175647;5579.107342825209;5611.102223644198;6067;6092.3603021682975;6343.333949935282;107197;109461.45269273603;110486.44756776164;112667.4366628178;116253.41873290579;95779.52110239543;96028;96831;99528.50235748776;100202.4989875046;78867.60566197132;79903.60048199721;82157.58921205356;83064.99999999879;85737.57131214428;11961;12213;12395.879000438592;12652.493900243888;12962.481500739865;38120.61879381171;38308.616913830505;38972;40450.1909961805;42185.156296874506;70675.29324706687;71389;71512;73478.63260683662;75135.62432187804;18697.813021869606;18809.05954702287;18856.622867542847;18917;19104.522386940436;20233.6964945523;21916.23293184731;22014.44963875916;22041;22089.558208835413;18711.345102921332;18937.147828347483;18971.90514047421;18986.145623447253;19003.619927601096;18557.536061598566;19345;19410.4176874694;19573.70639440381;19760.308389206308;18502.167402466654;18571.81428185755;18793;18793.34223302178;18827.90586047061;14053.718925621635;14072.577822665336;14156.150630962175;14172.078814877;14239.715205696035;13859;13937.17078631443;14702.191379473803;14715.632109197355;14834.664880160837 11:31:18 INFO - PID 15958 | __end_tp_report 11:31:18 INFO - PID 15958 | __start_cc_report 11:31:18 INFO - PID 15958 | _x_x_mozilla_cycle_collect,373 11:31:18 INFO - PID 15958 | __end_cc_report 11:31:18 INFO - PID 15958 | __startTimestamp1504031478674__endTimestamp 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | ------- Summary: start ------- 11:31:18 INFO - PID 15958 | Number of tests: 6 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | [#0] dojo.html Cycles:165 Average:6164.08 Median:6408.52 stddev:749.43 (11.7%) stddev-sans-first:717.30 11:31:18 INFO - PID 15958 | Values: 3301.9 3315.1 3337.6 3345.6 3374.8 6187.2 6226.4 6238.3 6286.5 6374.5 6292.9 6366.2 6384.1 6404.7 6408.5 5762.9 5813.7 5831.9 5874.9 5876.1 5638.3 5703.7 5723.3 5770.5 5796.6 5705.0 5785.5 5793.7 5826.3 5832.8 5714.7 5742.9 5754.7 5764.3 5795.5 5529.3 5649.2 5708.7 5731.2 5746.1 6186.6 6228.0 6235.4 6275.4 6276.3 6689.7 6693.5 6761.0 6772.4 6783.6 6640.7 6733.0 6744.7 6841.1 6845.5 6254.0 6266.9 6275.6 6278.7 6279.1 6889.0 6905.2 6970.0 6972.7 6995.3 6511.3 6542.4 6590.1 6606.7 6618.1 6693.3 6710.2 6710.7 6712.9 6713.7 6616.4 6620.1 6622.3 6630.1 6640.0 6648.2 6652.1 6653.4 6678.5 6687.1 4906.7 4907.2 4959.3 4959.7 4975.0 4324.7 4333.2 4341.9 4379.9 4398.1 5817.0 5879.0 5889.2 5891.3 5894.7 6741.2 6777.6 6784.9 6798.0 6829.2 5827.9 5838.6 5919.8 5928.3 5929.7 5625.2 5746.1 5750.8 5826.2 5826.5 6486.5 6488.4 6545.7 6549.4 6580.2 6735.9 6769.3 6809.3 6821.0 6821.8 6476.7 6478.3 6517.9 6580.5 6588.6 6567.5 6617.7 6626.9 6641.5 6736.2 6716.9 6736.4 6772.1 6774.5 6790.7 6371.5 6450.5 6542.1 6557.1 6559.7 6386.9 6439.8 6462.6 6533.2 6539.7 6404.6 6434.4 6470.9 6499.3 6527.8 6530.2 6566.1 6586.5 6603.4 6632.1 6174.2 6271.8 6298.2 6312.5 6313.7 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | [#1] ext.html Cycles:180 Average:37339.05 Median:3509.09 stddev:54324.97 (1548.1%) stddev-sans-first:54408.06 11:31:18 INFO - PID 15958 | Values: 792.3 835.4 872.2 875.0 1106.5 28236.4 29077.0 39088.0 40083.4 40101.6 39798.4 40113.2 40138.6 40140.8 40179.0 7258.6 7644.5 7851.3 7858.5 7870.4 7656.8 7759.6 7760.9 7761.7 7762.1 7743.8 7790.3 7792.1 7807.4 7812.4 7750.9 7779.4 7781.8 7792.0 7792.2 7704.1 7726.2 7742.0 7746.4 7748.3 36007.5 36095.0 36138.3 36139.5 36189.8 3481.1 3507.3 3510.9 3519.4 3519.9 29479.6 29695.4 29695.7 29718.9 29754.7 5081.5 5087.3 5090.5 5134.6 5168.4 180218.0 183281.0 183439.0 184060.0 184415.0 44580.1 45036.3 45122.0 45156.0 45246.5 46730.8 46858.3 46994.5 47071.3 47095.3 12856.8 15065.2 15073.8 15350.0 15409.8 10621.4 11668.1 11926.9 11956.4 11959.0 13711.7 13727.2 13760.2 13828.0 13834.8 5540.7 5603.2 5606.7 5621.3 5675.8 974.5 1005.5 1006.1 1011.3 1014.3 22110.9 22446.6 22485.3 22694.5 22754.9 1100.2 1105.2 1106.1 1111.0 1114.5 11670.7 11904.8 12006.0 12013.2 15111.5 238765.0 239728.0 240727.0 240968.0 241311.0 53087.2 53768.5 53798.0 53861.0 53899.7 1385.1 1413.6 1416.6 1425.7 1435.4 26182.6 26351.2 26720.2 26722.6 26751.2 36147.3 36466.6 36488.5 36514.3 36559.0 200353.0 200703.0 200740.0 202097.0 202633.0 31573.8 31806.0 35773.6 36662.0 36738.6 42613.8 43809.0 43875.0 44370.3 44426.1 32112.5 32687.7 32750.8 33091.2 33144.8 31744.0 32740.0 32799.2 33335.3 33433.7 36730.3 37203.6 37366.3 37476.6 37568.8 31512.0 32052.7 32082.7 32112.2 32736.5 23304.5 23575.6 23962.3 24047.2 24395.8 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | [#2] jquery.html Cycles:180 Average:36384.32 Median:22042.39 stddev:83600.71 (379.3%) stddev-sans-first:83791.92 11:31:18 INFO - PID 15958 | Values: 544.6 553.7 565.7 568.2 573.6 21274.0 21945.3 21977.5 21979.3 22105.4 24776.0 25099.1 25126.6 25170.5 25244.6 6629.0 6771.4 6774.4 6774.7 6799.8 6351.4 6552.8 6883.7 6946.5 6953.3 6934.0 6957.9 6958.3 6961.5 6961.8 6913.2 6914.6 6924.2 6926.6 6930.1 6742.2 6764.8 6777.6 6789.6 6791.8 29712.3 30803.8 31780.8 31871.5 31945.2 2131.5 2178.5 2182.8 2189.3 2189.7 19853.7 20797.4 20807.3 20815.8 20875.8 2502.9 2524.8 2587.3 2595.8 2598.2 137955.3 144569.0 144698.6 145564.3 145674.3 21418.5 21952.1 22168.8 22274.8 22436.6 41230.0 41253.8 41304.6 41365.6 41401.6 11141.1 11251.4 11266.2 11275.9 11282.7 9266.6 9314.1 9319.8 9338.7 9451.2 11511.3 11512.8 11741.5 11808.2 11819.8 4154.0 4203.6 4257.4 4316.9 4385.4 947.1 969.1 976.8 977.5 994.9 18996.7 19041.5 19075.0 19298.2 19541.0 1000.4 1020.3 1022.3 1028.4 1031.2 10219.5 10455.5 10510.5 10815.7 10839.0 459625.0 474858.0 476978.0 477776.0 572073.0 122641.0 127721.0 128654.0 128672.0 128706.4 1163.6 1212.2 1214.2 1219.5 1235.1 20708.5 20928.7 20980.7 21324.9 21349.6 58883.0 59430.0 60153.4 60581.4 61871.1 69513.7 70050.0 70272.3 70547.3 70691.0 14135.6 14375.1 14608.6 14629.0 14670.9 22863.4 22876.8 22887.4 22923.1 23145.0 16227.6 16851.7 16968.2 16993.2 17146.3 16781.8 16821.3 17220.7 17630.3 17664.6 18448.8 19697.6 19705.2 19912.3 19917.8 14395.4 14614.7 14622.9 14638.0 14654.2 17998.6 18348.4 18455.7 18753.8 18778.2 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | [#3] mootools.html Cycles:180 Average:9081.95 Median:2610.50 stddev:6337.14 (242.8%) stddev-sans-first:6328.08 11:31:18 INFO - PID 15958 | Values: 1319.4 1387.2 1394.2 1404.5 1404.8 12541.2 14507.2 15209.9 15213.9 15229.8 12626.7 14643.6 15179.8 15182.2 15185.7 2556.4 2609.5 2611.5 2612.3 2612.4 2622.6 2839.3 2842.7 2842.7 2863.4 2708.6 2735.3 2742.1 2779.6 2790.2 2619.2 2619.5 2641.0 2641.4 2646.1 2632.1 2643.8 2654.3 2656.8 2657.7 14340.5 14635.8 14675.8 14677.3 14690.2 7778.8 8000.5 8039.7 8061.0 8069.0 5389.2 5551.1 5558.5 5703.1 5762.4 1930.5 1933.0 1939.7 1970.6 1974.3 24566.0 24639.8 24676.8 24733.9 24784.4 6333.2 6343.7 6614.2 6641.5 6758.3 16225.2 16261.3 16281.0 16304.0 16311.4 7552.7 7826.5 7826.8 7828.3 7833.5 7137.1 7186.8 7206.2 7251.6 7263.9 4686.9 4867.4 4882.5 4905.8 5011.2 1323.7 1342.2 1349.1 1361.5 1364.7 871.1 890.1 899.1 904.8 907.6 7464.4 7514.8 7525.4 7546.0 7575.8 720.6 731.5 979.3 1012.2 1015.7 5045.0 5098.4 5107.6 5220.6 5239.7 20470.4 20872.8 21090.2 21406.8 21420.4 19546.4 20779.4 20780.3 20847.6 20899.3 10958.9 11169.2 11188.6 11192.6 11212.4 8087.6 8148.7 8226.1 8305.7 8349.7 17513.7 17874.6 18085.6 18249.0 18273.4 17668.4 17793.8 17836.4 18096.1 18158.9 11956.1 11971.0 12186.3 12194.0 12199.8 13597.3 13642.5 13773.3 13777.5 13786.1 10718.4 10764.0 10973.2 10988.9 11129.2 10806.7 10812.6 10865.8 11030.2 11071.2 9809.4 9936.0 9983.9 10073.1 10077.3 7494.5 7555.5 7594.5 7599.5 7666.3 7426.3 7594.9 7637.4 7740.6 7770.4 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | [#4] prototype.html Cycles:180 Average:5534.72 Median:6196.77 stddev:1570.29 (25.3%) stddev-sans-first:1528.51 11:31:18 INFO - PID 15958 | Values: 497.9 504.8 523.5 526.9 527.0 6278.7 6366.3 6368.4 6399.1 6455.0 6071.9 6156.2 6188.9 6241.6 6285.3 4974.2 4986.5 5001.2 5014.0 5061.5 4932.6 4995.4 5003.3 5044.4 5048.4 4832.3 4920.8 4966.7 4972.9 4987.8 4978.3 4993.9 5015.0 5015.2 5017.5 4458.2 4459.7 4459.7 4466.1 4470.6 6174.0 6193.8 6199.7 6208.0 6211.5 5631.9 5663.1 5671.9 5698.1 5710.0 6515.3 6534.3 6626.2 6634.2 6666.8 4840.4 4851.5 4864.7 4865.7 4881.0 6895.9 6917.5 6936.8 6984.7 7014.3 4946.9 4974.7 5002.7 5031.9 5046.2 5026.4 5063.2 5069.3 5088.9 5104.6 5662.0 5663.9 5666.8 5720.9 5724.5 6735.3 6735.9 6741.6 6754.4 6770.9 1625.8 1674.7 1709.3 1723.8 1730.0 1121.5 1176.0 1205.2 1213.3 1220.1 5696.2 5751.9 5790.7 5825.2 5838.3 6578.2 6584.6 6631.8 6696.0 6739.8 5725.8 5745.8 5804.1 5812.9 5859.3 3487.5 3557.0 3567.1 3590.9 3606.6 6414.6 6422.6 6525.4 6588.6 6605.4 6829.0 6879.5 6959.0 6964.6 7011.2 6467.7 6469.5 6569.8 6620.6 6633.0 6646.4 6734.9 6767.4 6767.5 6799.5 6651.4 6700.5 6766.4 6775.6 6796.4 6525.5 6550.5 6572.7 6578.4 6645.8 4936.0 4940.1 4974.4 4997.2 5003.2 6731.4 6791.9 6798.8 6807.8 6813.4 6409.7 6459.9 6522.4 6568.0 6620.2 6417.0 6418.6 6537.9 6550.4 6599.9 5985.3 6532.8 6555.4 6555.4 6565.7 6633.2 6633.8 6660.4 6667.7 6671.4 6217.2 6407.4 6414.2 6427.2 6505.7 11:31:18 INFO - PID 15958 | 11:31:18 INFO - PID 15958 | [#5] yui.html Cycles:180 Average:23812.04 Median:21247.07 stddev:31956.76 (150.4%) stddev-sans-first:31999.95 11:31:18 INFO - PID 15958 | Values: 864.1 882.4 886.6 890.2 896.8 17266.2 17474.7 17539.4 18037.7 21481.2 20548.8 21335.3 21383.6 21511.9 21598.7 884.4 903.5 905.7 905.9 911.4 914.6 946.1 946.9 949.9 951.7 1003.1 1006.7 1007.0 1007.2 1007.3 1001.1 1005.7 1006.3 1006.6 1006.9 733.7 740.1 740.2 740.4 740.6 18601.0 18828.7 18968.6 19417.4 19447.3 19973.4 20592.2 20782.2 21149.5 21158.9 16502.3 16741.2 16744.7 16865.8 16886.7 3641.1 3658.4 3665.4 3666.1 3668.9 121849.4 122369.4 123431.0 128407.0 129464.4 16604.9 16924.0 17111.4 17239.8 17342.7 28542.9 30333.5 30365.5 30389.5 30426.7 8645.8 8901.0 8922.5 8923.0 8937.0 4037.7 4124.6 4128.4 4128.5 4146.1 5106.9 5166.4 5202.0 5211.2 5214.2 994.1 1026.8 1030.8 1030.8 1036.0 640.5 685.1 701.2 710.2 713.1 11520.4 11525.3 11649.5 12351.7 12501.9 693.9 694.1 695.1 697.5 702.1 5579.1 5611.1 6067.0 6092.4 6343.3 107197.0 109461.5 110486.4 112667.4 116253.4 95779.5 96028.0 96831.0 99528.5 100202.5 78867.6 79903.6 82157.6 83065.0 85737.6 11961.0 12213.0 12395.9 12652.5 12962.5 38120.6 38308.6 38972.0 40450.2 42185.2 70675.3 71389.0 71512.0 73478.6 75135.6 18697.8 18809.1 18856.6 18917.0 19104.5 20233.7 21916.2 22014.4 22041.0 22089.6 18711.3 18937.1 18971.9 18986.1 19003.6 18557.5 19345.0 19410.4 19573.7 19760.3 18502.2 18571.8 18793.0 18793.3 18827.9 14053.7 14072.6 14156.2 14172.1 14239.7 13859.0 13937.2 14702.2 14715.6 14834.7 11:31:18 INFO - PID 15958 | -------- Summary: end -------- 11:31:18 INFO - PID 15958 | 11:31:19 INFO - TEST-INFO | 15958: exit 0 11:31:19 INFO - TEST-OK | dromaeo_css | took 1111955ms 11:31:19 INFO - TEST-START | kraken 11:31:19 INFO - Initialising browser for kraken test... 11:31:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40039/getInfo.html -profile /tmp/tmpdMcvX7/profile 11:31:19 INFO - TEST-INFO | started process 16327 (/builds/slave/test/build/application/firefox/firefox http://localhost:40039/getInfo.html) 11:31:25 INFO - TEST-INFO | 16327: exit 0 11:31:25 INFO - Browser initialized. 11:31:25 INFO - Running cycle 1/1 for kraken test... 11:31:25 INFO - Using env: {'DISPLAY': ':0', 11:31:25 INFO - 'HOME': '/home/cltbld', 11:31:25 INFO - 'JSGC_DISABLE_POISONING': '1', 11:31:25 INFO - 'LANG': 'en_US.UTF-8', 11:31:25 INFO - 'LANGUAGE': 'en_US:en', 11:31:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:31:25 INFO - 'LOGNAME': 'cltbld', 11:31:25 INFO - 'MAIL': '/var/mail/cltbld', 11:31:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:25 INFO - 'MOZ_CRASHREPORTER': '1', 11:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:31:25 INFO - 'MOZ_NO_REMOTE': '1', 11:31:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:25 INFO - 'NO_EM_RESTART': '1', 11:31:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:25 INFO - 'PWD': '/builds/slave/test', 11:31:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:25 INFO - 'RUST_BACKTRACE': 'full', 11:31:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:31:25 INFO - 'SHELL': '/bin/bash', 11:31:25 INFO - 'SHLVL': '1', 11:31:25 INFO - 'TERM': 'linux', 11:31:25 INFO - 'TMOUT': '86400', 11:31:25 INFO - 'USER': 'cltbld', 11:31:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1504027759.962957-1839089101', 11:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:25 INFO - '_': '/tools/buildbot/bin/python'} 11:31:25 INFO - TEST-INFO | started process 16503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdMcvX7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:26 INFO - PID 16503 | 11:31:26 INFO - PID 16503 | (/builds/slave/test/build/application/firefox/firefox:16553): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:31:26 INFO - PID 16503 | 11:31:37 INFO - PID 16503 | RSS: Main: 170848256 11:31:37 INFO - PID 16503 | 11:31:39 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40039/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:40 INFO - PID 16503 | RSS: Main: 176345088 11:31:40 INFO - PID 16503 | 11:31:43 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40039/tests/kraken/driver.html?testName=audio-dft) 11:31:43 INFO - PID 16503 | RSS: Main: 176472064 11:31:43 INFO - PID 16503 | 11:31:46 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40039/tests/kraken/driver.html?testName=audio-fft) 11:31:47 INFO - PID 16503 | RSS: Main: 170725376 11:31:47 INFO - PID 16503 | 11:31:49 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40039/tests/kraken/driver.html?testName=audio-oscillator) 11:31:50 INFO - PID 16503 | RSS: Main: 171765760 11:31:50 INFO - PID 16503 | 11:31:52 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40039/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:52 INFO - PID 16503 | RSS: Main: 171937792 11:31:52 INFO - PID 16503 | 11:31:55 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40039/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:56 INFO - PID 16503 | RSS: Main: 174407680 11:31:56 INFO - PID 16503 | 11:32:00 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40039/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:00 INFO - PID 16503 | RSS: Main: 174530560 11:32:00 INFO - PID 16503 | 11:32:03 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40039/tests/kraken/driver.html?testName=json-parse-financial) 11:32:04 INFO - PID 16503 | RSS: Main: 174923776 11:32:04 INFO - PID 16503 | 11:32:05 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40039/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:06 INFO - PID 16503 | RSS: Main: 174661632 11:32:06 INFO - PID 16503 | 11:32:08 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:08 INFO - PID 16503 | RSS: Main: 174903296 11:32:08 INFO - PID 16503 | 11:32:10 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:11 INFO - PID 16503 | RSS: Main: 172306432 11:32:11 INFO - PID 16503 | 11:32:13 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:14 INFO - PID 16503 | RSS: Main: 172208128 11:32:14 INFO - PID 16503 | 11:32:17 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:18 INFO - PID 16503 | RSS: Main: 172666880 11:32:18 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | Cycle 1(1): loaded http://localhost:40039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40039/tests/kraken/driver.html?testName=ai-astar) 11:32:20 INFO - PID 16503 | RSS: Main: 174338048 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | __start_tp_report 11:32:20 INFO - PID 16503 | _x_x_mozilla_page_load 11:32:20 INFO - PID 16503 | _x_x_mozilla_page_load_details 11:32:20 INFO - PID 16503 | |i|pagename|runs| 11:32:20 INFO - PID 16503 | |0;ai-astar;98;107;99;107;107;108;110;99;108;108 11:32:20 INFO - PID 16503 | |1;audio-beat-detection;144;117;149;178;116;137;144;116;176;118 11:32:20 INFO - PID 16503 | |2;audio-dft;164;165;162;164;164;162;161;172;169;165 11:32:20 INFO - PID 16503 | |3;audio-fft;75;75;74;166;74;74;72;75;153;75 11:32:20 INFO - PID 16503 | |4;audio-oscillator;77;79;128;80;81;80;128;78;79;126 11:32:20 INFO - PID 16503 | |5;imaging-gaussian-blur;113;113;114;113;114;114;114;114;113;114 11:32:20 INFO - PID 16503 | |6;imaging-darkroom;148;148;148;148;148;148;148;148;148;148 11:32:20 INFO - PID 16503 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;93 11:32:20 INFO - PID 16503 | |8;json-parse-financial;52;52;52;51;51;53;52;51;52;54 11:32:20 INFO - PID 16503 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;39;38;37 11:32:20 INFO - PID 16503 | |10;stanford-crypto-aes;75;76;86;74;78;74;73;79;74;74 11:32:20 INFO - PID 16503 | |11;stanford-crypto-ccm;120;120;117;120;123;135;114;114;126;155 11:32:20 INFO - PID 16503 | |12;stanford-crypto-pbkdf2;182;174;175;178;167;184;168;172;172;175 11:32:20 INFO - PID 16503 | |13;stanford-crypto-sha256-iterative;67;64;65;65;64;70;62;68;64;63 11:32:20 INFO - PID 16503 | __end_tp_report 11:32:20 INFO - PID 16503 | __start_cc_report 11:32:20 INFO - PID 16503 | _x_x_mozilla_cycle_collect,954 11:32:20 INFO - PID 16503 | __end_cc_report 11:32:20 INFO - PID 16503 | __startTimestamp1504031540360__endTimestamp 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | ------- Summary: start ------- 11:32:20 INFO - PID 16503 | Number of tests: 14 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#0] ai-astar Cycles:10 Average:105.10 Median:109.00 stddev:4.53 (4.2%) stddev-sans-first:4.01 11:32:20 INFO - PID 16503 | Values: 98.0 107.0 99.0 107.0 107.0 108.0 110.0 99.0 108.0 108.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:144.00 stddev:23.63 (16.4%) stddev-sans-first:25.00 11:32:20 INFO - PID 16503 | Values: 144.0 117.0 149.0 178.0 116.0 137.0 144.0 116.0 176.0 118.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.36 (2.0%) stddev-sans-first:3.55 11:32:20 INFO - PID 16503 | Values: 164.0 165.0 162.0 164.0 164.0 162.0 161.0 172.0 169.0 165.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#3] audio-fft Cycles:10 Average:91.30 Median:74.50 stddev:36.09 (48.4%) stddev-sans-first:37.79 11:32:20 INFO - PID 16503 | Values: 75.0 75.0 74.0 166.0 74.0 74.0 72.0 75.0 153.0 75.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.00 stddev:23.31 (29.5%) stddev-sans-first:23.94 11:32:20 INFO - PID 16503 | Values: 77.0 79.0 128.0 80.0 81.0 80.0 128.0 78.0 79.0 126.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:32:20 INFO - PID 16503 | Values: 113.0 113.0 114.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:32:20 INFO - PID 16503 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:32:20 INFO - PID 16503 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 11:32:20 INFO - PID 16503 | Values: 52.0 52.0 52.0 51.0 51.0 53.0 52.0 51.0 52.0 54.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 11:32:20 INFO - PID 16503 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 37.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:3.92 (5.2%) stddev-sans-first:4.13 11:32:20 INFO - PID 16503 | Values: 75.0 76.0 86.0 74.0 78.0 74.0 73.0 79.0 74.0 74.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:121.50 stddev:12.39 (10.2%) stddev-sans-first:13.04 11:32:20 INFO - PID 16503 | Values: 120.0 120.0 117.0 120.0 123.0 135.0 114.0 114.0 126.0 155.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.00 stddev:5.48 (3.1%) stddev-sans-first:5.13 11:32:20 INFO - PID 16503 | Values: 182.0 174.0 175.0 178.0 167.0 184.0 168.0 172.0 172.0 175.0 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:2.44 (3.8%) stddev-sans-first:2.50 11:32:20 INFO - PID 16503 | Values: 67.0 64.0 65.0 65.0 64.0 70.0 62.0 68.0 64.0 63.0 11:32:20 INFO - PID 16503 | -------- Summary: end -------- 11:32:20 INFO - PID 16503 | 11:32:20 INFO - PID 16503 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:32:21 INFO - TEST-INFO | 16503: exit 0 11:32:21 INFO - TEST-OK | kraken | took 61662ms 11:32:21 INFO - SUITE-END | took 1173s 11:32:21 INFO - Completed test suite (00:19:34) 11:32:21 INFO - javascript benchmark 11:32:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8593.520886747754, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.884434044809, 3315.1049216711485, 3337.649546797587, 3345.6487068857787, 3374.780639258448, 6187.164732761076, 6226.4084911933405, 6238.251409830821, 6286.497080233582, 6374.490040796737, 6292.905606415896, 6366.236051673805, 6384.138141350916, 6404.6797660117045, 6408.519361047916, 5762.942370576304, 5813.73838177281, 5831.854203644922, 5874.911876321838, 5876.08920617305, 5638.323401191863, 5703.686297253649, 5723.2559767230205, 5770.538356931456, 5796.594238403313, 5704.971475142618, 5785.508231800302, 5793.681347525884, 5826.329972053205, 5832.825015249549, 5714.685692286923, 5742.942570574282, 5754.6547207167705, 5764.250647415851, 5795.478406943395, 5529.253550770675, 5649.23735295734, 5708.686022268774, 5731.168980497804, 5746.109353050284, 6186.597871138407, 6227.96886015567, 6235.407636274546, 6275.403836635558, 6276.278228003793, 6689.6989635466525, 6693.497987650897, 6761.0, 6772.356626120511, 6783.6269005204695, 6640.7343706251695, 6733.0, 6744.696488658022, 6841.144856892888, 6845.520813543004, 6254.030625253093, 6266.905996410058, 6275.560710750249, 6278.6546739929745, 6279.089532017878, 6889.0355350251, 6905.1713794344, 6970.024196612479, 6972.6862291196, 6995.300469952964, 6511.251206111263, 6542.378474044958, 6590.143281373486, 6606.7026983785845, 6618.139641846626, 6693.263740988487, 6710.1947766267385, 6710.731570737214, 6712.865742685119, 6713.69788359525, 6616.371444712745, 6620.073189753439, 6622.2715501294815, 6630.138082049302, 6640.037194606755, 6648.235452922879, 6652.101966234593, 6653.401193892573, 6678.465722742169, 6687.097241872382, 4906.656534042654, 4907.1657818171, 4959.330490383824, 4959.702417854868, 4975.0, 4324.675649326313, 4333.155034768253, 4341.869743907688, 4379.912401752011, 4398.076403955141, 5817.0, 5879.029960056543, 5889.204957330706, 5891.322497912709, 5894.6757928314355, 6741.1910570731825, 6777.6272305023695, 6784.93215067843, 6798.04827324175, 6829.180498340231, 5827.912581311284, 5838.649681019152, 5919.792807251725, 5928.258967629046, 5929.703514824328, 5625.212470254168, 5746.080627099644, 5750.769969201185, 5826.184334193216, 5826.504747096459, 6486.513511486657, 6488.416042556192, 6545.705443255065, 6549.377809108032, 6580.177477815273, 6735.898961515483, 6769.289224631343, 6809.250982392032, 6820.965895170492, 6821.795346139425, 6476.740930362733, 6478.28738838718, 6517.8696426072165, 6580.473562114924, 6588.637624930483, 6567.540272180901, 6617.735290588323, 6626.933730662631, 6641.501887358564, 6736.191657001191, 6716.899246511404, 6736.427403670743, 6772.0857684212, 6774.491913106635, 6790.694418751069, 6371.522135839923, 6450.516211284079, 6542.051402546509, 6557.082008518716, 6559.704813283509, 6386.872262554816, 6439.774607888701, 6462.612243265231, 6533.248676402084, 6539.70571324282, 6404.551681382259, 6434.420902118832, 6470.935290647221, 6499.252585952676, 6527.771527996498, 6530.249021362604, 6566.146400967844, 6586.50601204902, 6603.438707709898, 6632.071509988509, 6174.197354343906, 6271.843203919939, 6298.1812364392335, 6312.495000400048, 6313.652749098844], "value": 6107.763288727986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.2592376128321, 835.3609488741114, 872.1932212703252, 875.0, 1106.4578356605266, 28236.435271294562, 29077.0, 39088.0, 40083.39874901879, 40101.598984010154, 39798.40302395466, 40113.19773604533, 40138.59861401392, 40140.799296003555, 40179.0, 7258.564486130849, 7644.5031072980355, 7851.254130857588, 7858.528488290693, 7870.370370370357, 7656.846863062736, 7759.6120193990355, 7760.922390776104, 7761.650725717356, 7762.068551773795, 7743.806404839896, 7790.337821285198, 7792.103908050562, 7807.414443916729, 7812.414068944823, 7750.922490775077, 7779.416543759241, 7781.766547003599, 7791.961040194791, 7792.220777922247, 7704.075510938667, 7726.188750181263, 7741.961290193569, 7746.41901857363, 7748.302652761278, 36007.4598881017, 36095.0, 36138.277234455425, 36139.4579081314, 36189.81905090484, 3481.0601137692934, 3507.2985402919517, 3510.8771193008124, 3519.419295816187, 3519.9472007919644, 29479.557806632918, 29695.40609187804, 29695.70304296951, 29718.851405742833, 29754.70245297541, 5081.466446023152, 5087.26234695967, 5090.541851233407, 5134.563562097189, 5168.431472538018, 180218.0, 183281.0, 183439.0, 184060.0, 184415.0, 44580.108397831864, 45036.3244551332, 45122.0, 45156.0, 45246.54753452489, 46730.76634616805, 46858.29712554315, 46994.53005469902, 47071.29393059107, 47095.29357059647, 12856.807147892789, 15065.17141557225, 15073.849261507465, 15350.0, 15409.845901541064, 10621.362718236776, 11668.124890633237, 11926.88073119275, 11956.402179891145, 11959.0, 13711.725765484634, 13727.245001524812, 13760.17438953666, 13828.0, 13834.792478112837, 5540.722963851791, 5603.187537806995, 5606.6636001840025, 5621.297337832771, 5675.801346952837, 974.4932635029745, 1005.4922264256504, 1006.1146191351564, 1011.2971484817981, 1014.2747935226201, 22110.889445552668, 22446.551068978857, 22485.32544023682, 22694.546109077724, 22754.886225568767, 1100.1913593508764, 1105.1876870500175, 1106.0653747583278, 1110.9944450277696, 1114.4594871487323, 11670.70823229426, 11904.821253196782, 12006.039516838631, 12013.159078864395, 15111.54665360041, 238765.0, 239728.0, 240727.0, 240968.0, 241311.0, 53087.203691944655, 53768.462315376346, 53798.0, 53861.0, 53899.73050134724, 1385.12044851518, 1413.5971248194421, 1416.5608661314818, 1425.6934759026858, 1435.3756116089326, 26182.60726089072, 26351.20946371612, 26720.19839404821, 26722.59916101221, 26751.197464076107, 36147.27705445929, 36466.63533364632, 36488.45267321046, 36514.26971460609, 36559.0, 200353.0, 200703.0, 200740.0, 202097.0, 202633.0, 31573.8421307892, 31806.0, 35773.64226357703, 36662.0, 36738.63261367352, 42613.786931065144, 43809.0, 43875.0, 44370.334444982705, 44426.11147776962, 32112.518312224867, 32687.67312326846, 32750.836245818617, 33091.172720681214, 33144.83427582846, 31744.04767856968, 32740.0, 32799.180020499676, 33335.33329333448, 33433.665663343054, 36730.26539469142, 37203.62796372001, 37366.252674946896, 37476.62523374731, 37568.81215593904, 31512.0, 32052.67947320497, 32082.679173208904, 32112.197195070312, 32736.50895236621, 23304.533909322057, 23575.64636530419, 23962.28113156608, 24047.158349457684, 24395.75604243935], "value": 16957.856291682536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.6269305525715, 553.6843998920617, 565.6577770448876, 568.2016766443148, 573.5669569475047, 21274.0, 21945.34163975081, 21977.450563735896, 21979.340619781433, 22105.447363815914, 24776.0, 25099.121530746426, 25126.623100653505, 25170.49659006819, 25244.621330680053, 6628.972509261072, 6771.424428923548, 6774.356436138559, 6774.661266936633, 6799.76200832971, 6351.428371446569, 6552.770653027121, 6883.6558172091445, 6946.47901407394, 6953.269906659803, 6933.965330173367, 6957.860842783141, 6958.304169583052, 6961.547499412522, 6961.825954351131, 6913.20498142715, 6914.550554213985, 6924.23833378328, 6926.584404935695, 6930.13373328334, 6742.2246441659345, 6764.797056088325, 6777.62723050232, 6789.558678685869, 6791.830204244884, 29712.257193570116, 30803.84598076995, 31780.841095794603, 31871.52192717111, 31945.201369965936, 2131.456478597948, 2178.5425060737266, 2182.8253739700785, 2189.27753841232, 2189.693442917993, 19853.702194467096, 20797.37607871766, 20807.271745488986, 20815.791842081537, 20875.79124208769, 2502.949941001188, 2524.8106392020673, 2587.3143616941525, 2595.7923366130663, 2598.233521111277, 137955.31022344925, 144569.0, 144698.55301446957, 145564.27217863948, 145674.27162864225, 21418.464538386666, 21952.121915123535, 22168.778312216673, 22274.777252227595, 22436.551268974854, 41230.0, 41253.79373103175, 41304.586954130675, 41365.58634413678, 41401.58598414037, 11141.108711303077, 11251.381174035343, 11266.155038372155, 11275.943620281847, 11282.661520154408, 9266.583003764847, 9314.068593140631, 9319.767005824773, 9338.719838404859, 9451.243900487945, 11511.30932144074, 11512.769744605228, 11741.530338786524, 11808.173427859967, 11819.763604727857, 4153.979230103831, 4203.579642035772, 4257.3613957905945, 4316.892077698019, 4385.3641222022625, 947.1049857884371, 969.132626299458, 976.7948730766476, 977.4721650308895, 994.9054839790208, 18996.715049274273, 19041.523961901064, 19075.046247687562, 19298.22807087701, 19541.0, 1000.364768372089, 1020.2705065877933, 1022.3354819367322, 1028.388109075099, 1031.2059714020163, 10219.540120694586, 10455.529501172465, 10510.474476276155, 10815.67552973412, 10839.024487796136, 459625.0, 474858.0, 476978.0, 477776.0, 572073.0, 122641.0, 127721.0, 128654.0, 128672.0, 128706.35646821705, 1163.6450882480924, 1212.1999480342754, 1214.1552736784922, 1219.4634360881184, 1235.0613533714443, 20708.48228794232, 20928.686069708663, 20980.685289720972, 21324.89337553302, 21349.573008540054, 58883.0, 59430.0, 60153.39846601653, 60581.39418605934, 61871.071933920124, 69513.65243173752, 70050.0, 70272.29727702658, 70547.29452705613, 70691.0, 14135.575932722035, 14375.137491750529, 14608.634784130481, 14629.0, 14670.853291466949, 22863.428414289112, 22876.771232287465, 22887.42781430411, 22923.083076677412, 23145.0, 16227.594310142342, 16851.65186785079, 16968.236429360957, 16993.15034248258, 17146.314147433965, 16781.832181678026, 16821.327146914475, 17220.746009230257, 17630.294788208328, 17664.646707066044, 18448.81551184471, 19697.606047878675, 19705.211791528753, 19912.303069392503, 19917.800821991594, 14395.352209150404, 14614.707705846036, 14622.853771462149, 14638.0, 14654.19401932904, 17998.5500362492, 18348.357807476674, 18455.723164152816, 18753.812461875208, 18778.248870045045], "value": 12824.135606697384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.3732976836002, 1387.2162228340987, 1394.177435313165, 1404.4663028049347, 1404.8314202295724, 12541.247525148498, 14507.202103884281, 15209.923950380247, 15213.923930380346, 15229.771553426708, 12626.684332891682, 14643.63390915225, 15179.848201518009, 15182.164980926073, 15185.696286074271, 2556.3736884463287, 2609.5302845487804, 2611.4777044591065, 2612.255507180454, 2612.399148195916, 2622.55416579182, 2839.318563544755, 2842.6588809342907, 2842.7015163407855, 2863.3557449573887, 2708.5530887403556, 2735.3161709572605, 2742.0951086141627, 2779.5691667791525, 2790.2047916343745, 2619.1749598876295, 2619.4891996060774, 2641.022821556027, 2641.432092100198, 2646.1400044985457, 2632.065616706061, 2643.814932954694, 2654.283343497264, 2656.800739944512, 2657.720939301365, 14340.498082567165, 14635.780463293058, 14675.77986330206, 14677.339519721638, 14690.192039437827, 7778.844423111563, 8000.479968802009, 8039.678412863478, 8061.0, 8069.031716194036, 5389.191621256804, 5551.084071128259, 5558.471945165203, 5703.0589952657765, 5762.423757624204, 1930.536671198916, 1932.9710054349196, 1939.660559402113, 1970.6058788242265, 1974.3089918528544, 24566.0, 24639.753602463927, 24676.753232467625, 24733.876330618412, 24784.38039049002, 6333.20834895638, 6343.682815859189, 6614.173228346457, 6641.501887358468, 6758.324167583202, 16225.188740562924, 16261.349546018264, 16281.0, 16304.0, 16311.42909998168, 7552.66013029415, 7826.530408175528, 7826.8434631307055, 7828.334591559781, 7833.451658383859, 7137.10786151731, 7186.784396468114, 7206.207317195104, 7251.56490610565, 7263.89104163438, 4686.882827929329, 4867.367242258484, 4882.511748825089, 4905.754712264373, 5011.248312753043, 1323.7418703352946, 1342.2215115233141, 1349.0556610372778, 1361.5438827992534, 1364.7134101838526, 871.0679572857109, 890.0698769785589, 899.1008991008991, 904.791897863482, 907.5507623726297, 7464.440166987498, 7514.849703005909, 7525.360344370681, 7546.0, 7575.848483030309, 720.621673621353, 731.4587205468022, 979.2655508368723, 1012.2357619996856, 1015.720676813882, 5044.974775126101, 5098.388193416814, 5107.565856902205, 5220.634555581073, 5239.711815850089, 20470.38588842337, 20872.79127208739, 21090.156393744386, 21406.785932140792, 21420.357389278033, 19546.413607591796, 20779.376618701463, 20780.27269045576, 20847.583048338947, 20899.268525601532, 10958.945205274082, 11169.162312826571, 11188.552457901755, 11192.552297907992, 11212.383318917375, 8087.63605637736, 8148.6962086068315, 8226.095129535626, 8305.667773289, 8349.66601335964, 17513.737293940856, 17874.5531361717, 18085.638287234444, 18249.0, 18273.3604323848, 17668.381606643707, 17793.822061779218, 17836.3757268495, 18096.09519524045, 18158.90920545389, 11956.103292252941, 11971.0, 12186.268823870596, 12194.0, 12199.75600488003, 13597.252151131783, 13642.522511712043, 13773.311334433438, 13777.517786877412, 13786.103903246258, 10718.35689858611, 10764.0, 10973.177011724312, 10988.945055274673, 11129.220954533104, 10806.729831753955, 10812.567497300335, 10865.837012444661, 11030.172737044593, 11071.169662275523, 9809.411435313905, 9936.0, 9983.850242246517, 10073.093421592092, 10077.344972576759, 7494.475386722877, 7555.471117021756, 7594.544327340377, 7599.544027358376, 7666.310032097138, 7426.3188660675705, 7594.8860767089645, 7637.350825179922, 7740.612969351622, 7770.417218708506], "value": 6538.612980297873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.8921898775226, 504.8493418039154, 523.5000574451399, 526.8656492594392, 526.9631125821192, 6278.717457714402, 6366.262507121935, 6368.363163683629, 6399.136116624254, 6454.967725161374, 6071.939280607193, 6156.199694039779, 6188.907166392508, 6241.625502469844, 6285.277193122793, 4974.204127339626, 4986.4514903360605, 5001.224565279328, 5014.0, 5061.519155680223, 4932.630052746041, 4995.35060442142, 5003.2995380646735, 5044.445111037783, 5048.419431765357, 4832.299316599091, 4920.778564964585, 4966.726830024347, 4972.8508144755715, 4987.775550100236, 4978.303037574742, 4993.925091123636, 5014.974925125388, 5015.247712843066, 5017.5484206421415, 4458.242098843172, 4459.710118842265, 4459.732416055014, 4466.129104824528, 4470.619997300233, 6174.0, 6193.845153871144, 6199.690015499252, 6208.0, 6211.534134939852, 5631.915521267143, 5663.0655941769555, 5671.943280567183, 5698.116791897262, 5709.971450142764, 6515.315891831337, 6534.281229064846, 6626.204855417381, 6634.237062737799, 6666.766663166814, 4840.394950631171, 4851.490593487668, 4864.7324397158145, 4865.70805751656, 4880.975595122037, 6895.896561551581, 6917.51577389583, 6936.79189624312, 6984.685689144001, 7014.333638304353, 4946.8515944521005, 4974.676646017997, 5002.699838009731, 5031.899362012739, 5046.167382381939, 5026.39155470246, 5063.1645778446145, 5069.31564238823, 5088.949110508922, 5104.617153713486, 5662.027435596345, 5663.915041274384, 5666.801661941812, 5720.94046143388, 5724.4561766632105, 6735.326467353226, 6735.8989615155815, 6741.561798483083, 6754.3921047106, 6770.93229067703, 1625.8130315013689, 1674.7236705943626, 1709.3248166973976, 1723.7759091318298, 1729.9827001730073, 1121.545773961547, 1176.0474016046858, 1205.1744554979866, 1213.3144773203112, 1220.1398014399826, 5696.23100881384, 5751.884962300815, 5790.681512516768, 5825.242718446575, 5838.299404071538, 6578.243501997236, 6584.572002819801, 6631.801045968628, 6696.0, 6739.764108256188, 5725.77096916127, 5745.827625171251, 5804.129380592861, 5812.88374232513, 5859.326177489558, 3487.5466189395215, 3557.008075477741, 3567.073780158737, 3590.856365745341, 3606.6213047630145, 6414.61512309263, 6422.582532135396, 6525.412712855866, 6588.637624930579, 6605.438537724347, 6829.0, 6879.484038697117, 6959.007626720559, 6964.597213961175, 7011.193712723, 6467.741290348427, 6469.482441404676, 6569.80290591283, 6620.602763834186, 6632.966835165793, 6646.435053020354, 6734.8653026940165, 6767.35710107539, 6767.492438067263, 6799.524033317818, 6651.403663120719, 6700.4639628830555, 6766.357196066366, 6775.593464392152, 6796.35434633709, 6525.510586706111, 6550.543546170186, 6572.652606215619, 6578.375054369827, 6645.833854153685, 4936.0, 4940.135476291706, 4974.37820272466, 4997.200447928314, 5003.249512573143, 6731.394174524316, 6791.898121528082, 6798.830029249309, 6807.829804254933, 6813.420859226823, 6409.679516024087, 6459.870802583828, 6522.380373864476, 6568.047633093271, 6620.24563490685, 6417.016087519326, 6418.550701450854, 6537.934620653923, 6550.410463058348, 6599.9010014848855, 5985.3015382924195, 6532.824091663356, 6555.3772391622715, 6555.3772391622715, 6565.737370505126, 6633.2371777246235, 6633.834154146185, 6660.367265109807, 6667.666616669244, 6671.365515448746, 6217.222847144107, 6407.359264073555, 6414.198225221848, 6427.164468619049, 6505.674716264262], "value": 5067.963697587658, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.1099667342637, 882.3911501064265, 886.5965985476607, 890.2210565754964, 896.8027034052515, 17266.2230199641, 17474.737878931825, 17539.38612148575, 18037.729434058485, 21481.248156314494, 20548.794512054876, 21335.25326613565, 21383.57232855342, 21511.892440537813, 21598.676019859715, 884.4339622641498, 903.5346796399859, 905.732808821396, 905.9320550958671, 911.4166933162782, 914.6204325205065, 946.0633972367375, 946.9242460603135, 949.8765160529122, 951.7192428233653, 1003.0721582536162, 1006.718118926698, 1007.0, 1007.209340667576, 1007.3351587951953, 1001.099010890201, 1005.6731562242264, 1006.3358183598826, 1006.6023920551341, 1006.9496525173786, 733.6625152429889, 740.1192580828797, 740.1894925057107, 740.4261697184671, 740.6111791309552, 18601.0, 18828.717569236473, 18968.62062758737, 19417.417477475556, 19447.3193438229, 19973.400797976083, 20592.176312947464, 20782.168713251453, 21149.471263218387, 21158.894205529028, 16502.33990640373, 16741.246643900933, 16744.69678063389, 16865.831341686673, 16886.74669879953, 3641.1443310821937, 3658.432942893829, 3665.3585622515952, 3666.0834791302173, 3668.926621467556, 121849.39075304655, 122369.38815305955, 123431.0, 128407.0, 129464.35267823694, 16604.916975415286, 16924.0, 17111.401100961408, 17239.82760172382, 17342.65314693699, 28542.85728571344, 30333.544996825065, 30365.544516832266, 30389.544156837666, 30426.695733042387, 8645.783855403539, 8901.020887702347, 8922.464652120894, 8923.0, 8937.0, 4037.6769858411258, 4124.566920473367, 4128.401381799622, 4128.525219599785, 4146.087860670647, 5106.872328191751, 5166.405863325691, 5201.973990130025, 5211.192265198824, 5214.191800270964, 994.0606127209862, 1026.8357062870055, 1030.7989941961396, 1030.835066389389, 1035.9585616575403, 640.5196102922808, 685.0785693242581, 701.1516065560627, 710.1974768511652, 713.1371041040295, 11520.423978801195, 11525.308481491138, 11649.47577359021, 12351.69120771988, 12501.874981250254, 693.9375456208966, 694.1080711285973, 695.0963747128712, 697.5212549395314, 702.0592406175647, 5579.107342825209, 5611.102223644198, 6067.0, 6092.3603021682975, 6343.333949935282, 107197.0, 109461.45269273603, 110486.44756776164, 112667.4366628178, 116253.41873290579, 95779.52110239543, 96028.0, 96831.0, 99528.50235748776, 100202.4989875046, 78867.60566197132, 79903.60048199721, 82157.58921205356, 83064.99999999879, 85737.57131214428, 11961.0, 12213.0, 12395.879000438592, 12652.493900243888, 12962.481500739865, 38120.61879381171, 38308.616913830505, 38972.0, 40450.1909961805, 42185.156296874506, 70675.29324706687, 71389.0, 71512.0, 73478.63260683662, 75135.62432187804, 18697.813021869606, 18809.05954702287, 18856.622867542847, 18917.0, 19104.522386940436, 20233.6964945523, 21916.23293184731, 22014.44963875916, 22041.0, 22089.558208835413, 18711.345102921332, 18937.147828347483, 18971.90514047421, 18986.145623447253, 19003.619927601096, 18557.536061598566, 19345.0, 19410.4176874694, 19573.70639440381, 19760.308389206308, 18502.167402466654, 18571.81428185755, 18793.0, 18793.34223302178, 18827.90586047061, 14053.718925621635, 14072.577822665336, 14156.150630962175, 14172.078814877, 14239.715205696035, 13859.0, 13937.17078631443, 14702.191379473803, 14715.632109197355, 14834.664880160837], "value": 9149.545343804948, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1480.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 99.0, 107.0, 107.0, 108.0, 110.0, 99.0, 108.0, 108.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 149.0, 178.0, 116.0, 137.0, 144.0, 116.0, 176.0, 118.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 164.0, 164.0, 162.0, 161.0, 172.0, 169.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 166.0, 74.0, 74.0, 72.0, 75.0, 153.0, 75.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 128.0, 80.0, 81.0, 80.0, 128.0, 78.0, 79.0, 126.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 51.0, 51.0, 53.0, 52.0, 51.0, 52.0, 54.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 37.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 86.0, 74.0, 78.0, 74.0, 73.0, 79.0, 74.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 117.0, 120.0, 123.0, 135.0, 114.0, 114.0, 126.0, 155.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 174.0, 175.0, 178.0, 167.0, 184.0, 168.0, 172.0, 172.0, 175.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 65.0, 65.0, 64.0, 70.0, 62.0, 68.0, 64.0, 63.0], "value": 65.2, "unit": "score"}]}]} 11:32:21 INFO - Return code: 0 11:32:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:32:21 INFO - # TBPL SUCCESS # 11:32:21 INFO - Running post-action listener: _package_coverage_data 11:32:21 INFO - Running post-action listener: _resource_record_post_action 11:32:21 INFO - [mozharness: 2017-08-29 18:32:21.648624Z] Finished run-tests step (success) 11:32:21 INFO - Running post-run listener: _resource_record_post_run 11:32:21 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 431149056; Read time: 204; Write time: 668132 11:32:21 INFO - TinderboxPrint: CPU usage
13.1% 11:32:21 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 204 11:32:21 INFO - TinderboxPrint: I/O write bytes / time
431,149,056 / 668,132 11:32:21 INFO - TinderboxPrint: CPU idle
8,255.2 (86.9%) 11:32:21 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 11:32:21 INFO - TinderboxPrint: Swap in / out
0 / 0 11:32:21 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 111013888; Read time: 52; Write time: 153840 11:32:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:32:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319737856; Read time: 140; Write time: 514268 11:32:22 INFO - Running post-run listener: _upload_blobber_files 11:32:22 INFO - Blob upload gear active. 11:32:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:22 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 11:32:22 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'] 11:32:22 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 11:32:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:23 INFO - (blobuploader) - INFO - Done attempting. 11:32:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:32:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:24 INFO - (blobuploader) - INFO - Done attempting. 11:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:25 INFO - (blobuploader) - INFO - Done attempting. 11:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:32 INFO - (blobuploader) - INFO - Done attempting. 11:32:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:32 INFO - Return code: 0 11:32:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/236213215ef7a5573ea22f4ebe6ff16efce073b42b6aa608b88e3d4ab6ac5984befeee75b0b077fd053d45fedacbfedd16b2d1a01a413f8651484e789c2a7814", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ceb9fe04b8a6c9df9fa839b80c7cf575cd2119dfa579eae2db7c2995912853b9bac085db359f41e2a7dc82200d3eec822ea35d7051507b279f9f4b7f9d63d4c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91405a7097e13a85b11ddfec3d59be8a05986d2cba94b6788bb6fd910251e2da72613e1526f22ff34c745fb938d1bc505c8420b25270af6ee9b1d77b80233816", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ee7de6ce6869c367d93a788263f95cc3238709af9ec79830d66583d5cd4c48adda470e4f7d2eb3d14ece2e0f3709b7ddb73ce6844c0272a01202175658aed89"} 11:32:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:32 INFO - Contents: 11:32:32 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/236213215ef7a5573ea22f4ebe6ff16efce073b42b6aa608b88e3d4ab6ac5984befeee75b0b077fd053d45fedacbfedd16b2d1a01a413f8651484e789c2a7814", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ceb9fe04b8a6c9df9fa839b80c7cf575cd2119dfa579eae2db7c2995912853b9bac085db359f41e2a7dc82200d3eec822ea35d7051507b279f9f4b7f9d63d4c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91405a7097e13a85b11ddfec3d59be8a05986d2cba94b6788bb6fd910251e2da72613e1526f22ff34c745fb938d1bc505c8420b25270af6ee9b1d77b80233816", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ee7de6ce6869c367d93a788263f95cc3238709af9ec79830d66583d5cd4c48adda470e4f7d2eb3d14ece2e0f3709b7ddb73ce6844c0272a01202175658aed89"} 11:32:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:32 INFO - Copying logs to upload dir... 11:32:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.289637 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-29 11:32:32.545688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 11:32:32.550102) ========= 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-1504027759.962957-1839089101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/236213215ef7a5573ea22f4ebe6ff16efce073b42b6aa608b88e3d4ab6ac5984befeee75b0b077fd053d45fedacbfedd16b2d1a01a413f8651484e789c2a7814", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ceb9fe04b8a6c9df9fa839b80c7cf575cd2119dfa579eae2db7c2995912853b9bac085db359f41e2a7dc82200d3eec822ea35d7051507b279f9f4b7f9d63d4c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91405a7097e13a85b11ddfec3d59be8a05986d2cba94b6788bb6fd910251e2da72613e1526f22ff34c745fb938d1bc505c8420b25270af6ee9b1d77b80233816", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ee7de6ce6869c367d93a788263f95cc3238709af9ec79830d66583d5cd4c48adda470e4f7d2eb3d14ece2e0f3709b7ddb73ce6844c0272a01202175658aed89"} build_url:https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/J1Wwa5wdSOSum0rQh28Tpg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/236213215ef7a5573ea22f4ebe6ff16efce073b42b6aa608b88e3d4ab6ac5984befeee75b0b077fd053d45fedacbfedd16b2d1a01a413f8651484e789c2a7814", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ceb9fe04b8a6c9df9fa839b80c7cf575cd2119dfa579eae2db7c2995912853b9bac085db359f41e2a7dc82200d3eec822ea35d7051507b279f9f4b7f9d63d4c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91405a7097e13a85b11ddfec3d59be8a05986d2cba94b6788bb6fd910251e2da72613e1526f22ff34c745fb938d1bc505c8420b25270af6ee9b1d77b80233816", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ee7de6ce6869c367d93a788263f95cc3238709af9ec79830d66583d5cd4c48adda470e4f7d2eb3d14ece2e0f3709b7ddb73ce6844c0272a01202175658aed89"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 11:32:32.584714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:32:32.585104) ========= 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-1504027759.962957-1839089101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 11:32:32.668776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 11:32:32.669202) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 11:32:32.669624) ========= ========= Total master_lag: 0.36 =========