builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1501657384.17 results: success (0) revision: 320642944e42a889db13c6c55b404e32319d4de6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.167091) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.167565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.167869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.183663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.184017) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-02 00:03:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2017-08-02 00:03:04 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144185 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.341361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.341678) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:04.394463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-02 00:03:04.397787) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 320642944e42a889db13c6c55b404e32319d4de6 --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 320642944e42a889db13c6c55b404e32319d4de6 --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=6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-02 00:03:04,767 truncating revision to first 12 chars 2017-08-02 00:03:04,767 Setting DEBUG logging. 2017-08-02 00:03:04,768 attempt 1/10 2017-08-02 00:03:04,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/320642944e42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-02 00:03:05,258 attempt 1/10 2017-08-02 00:03:05,979 current task status: no status available at this point. state: STARTED 2017-08-02 00:03:05,980 sleeping for 11.00s (attempt 1/10) 2017-08-02 00:03:16,991 attempt 2/10 2017-08-02 00:03:17,293 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-02 00:03:17,514 unpacking tar archive at: mozilla-central-320642944e42/testing/mozharness/ program finished with exit code 0 elapsedTime=13.068453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-02 00:03:17.478718) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:17.480137) ========= script_repo_revision: 320642944e42a889db13c6c55b404e32319d4de6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:17.480492) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:17.480764) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 00:03:17.490373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-02 00:03:17.490642) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:03:17 INFO - MultiFileLogger online at 20170802 00:03:17 in /builds/slave/test 00:03:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 00:03:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:03:17 INFO - {'append_to_log': False, 00:03:17 INFO - 'base_work_dir': '/builds/slave/test', 00:03:17 INFO - 'blob_upload_branch': 'Firefox', 00:03:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:03:17 INFO - 'branch': 'Firefox', 00:03:17 INFO - 'buildbot_json_path': 'buildprops.json', 00:03:17 INFO - 'code_coverage': False, 00:03:17 INFO - 'config_files': ('talos/linux_config.py',), 00:03:17 INFO - 'default_actions': ('clobber', 00:03:17 INFO - 'read-buildbot-config', 00:03:17 INFO - 'download-and-extract', 00:03:17 INFO - 'populate-webroot', 00:03:17 INFO - 'create-virtualenv', 00:03:17 INFO - 'install', 00:03:17 INFO - 'setup-mitmproxy', 00:03:17 INFO - 'run-tests'), 00:03:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:03:17 INFO - 'disable_ccov_upload': False, 00:03:17 INFO - 'download_minidump_stackwalk': True, 00:03:17 INFO - 'download_symbols': 'ondemand', 00:03:17 INFO - 'enable_stylo': False, 00:03:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:03:17 INFO - 'tooltool.py': '/tools/tooltool.py', 00:03:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:03:17 INFO - '/tools/misc-python/virtualenv.py')}, 00:03:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:03:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:03:17 INFO - 'gecko_profile': False, 00:03:17 INFO - 'gecko_profile_interval': 0, 00:03:17 INFO - 'installer_path': 'installer.exe', 00:03:17 INFO - 'log_level': 'info', 00:03:17 INFO - 'log_name': 'talos', 00:03:17 INFO - 'log_to_console': True, 00:03:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:03:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:03:17 INFO - 'opt_config_files': (), 00:03:17 INFO - 'pip_index': False, 00:03:17 INFO - 'suite': 'dromaeojs-e10s', 00:03:17 INFO - 'system_bits': '32', 00:03:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:03:17 INFO - 'title': 'talos-linux64-ix-023', 00:03:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:03:17 INFO - 'use_talos_json': True, 00:03:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:03:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:03:17 INFO - 'work_dir': 'build'} 00:03:17 INFO - [mozharness: 2017-08-02 07:03:17.955502Z] Running clobber step. 00:03:17 INFO - Running pre-action listener: _resource_record_pre_action 00:03:17 INFO - Running main action method: clobber 00:03:17 INFO - rmtree: /builds/slave/test/build 00:03:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:03:19 INFO - Running post-action listener: _resource_record_post_action 00:03:19 INFO - [mozharness: 2017-08-02 07:03:19.504340Z] Finished clobber step (success) 00:03:19 INFO - [mozharness: 2017-08-02 07:03:19.504442Z] Running read-buildbot-config step. 00:03:19 INFO - Running pre-action listener: _resource_record_pre_action 00:03:19 INFO - Running main action method: read_buildbot_config 00:03:19 INFO - Using buildbot properties: 00:03:19 INFO - { 00:03:19 INFO - "project": "", 00:03:19 INFO - "product": "firefox", 00:03:19 INFO - "who": "philringnalda@gmail.com", 00:03:19 INFO - "installer_path": "public/build/target.tar.bz2", 00:03:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 00:03:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:03:19 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 00:03:19 INFO - "stage_platform": "linux64-stylosequential", 00:03:19 INFO - "basedir": "/builds/slave/test", 00:03:19 INFO - "buildnumber": 14, 00:03:19 INFO - "platform": "ubuntu64_hw_styloseq", 00:03:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:03:19 INFO - "slavebuilddir": "test", 00:03:19 INFO - "taskId": "JYcp-CFMT0Gl4eGCgq-VWQ", 00:03:19 INFO - "branch": "mozilla-central", 00:03:19 INFO - "script_repo_revision": "production", 00:03:19 INFO - "revision": "320642944e42a889db13c6c55b404e32319d4de6", 00:03:19 INFO - "slavename": "talos-linux64-ix-023", 00:03:19 INFO - "repo_path": "mozilla-central" 00:03:19 INFO - } 00:03:19 INFO - Finding installer, test and symbols from parent task. 00:03:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JYcp-CFMT0Gl4eGCgq-VWQ'}, attempt #1 00:03:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JYcp-CFMT0Gl4eGCgq-VWQ'}, attempt #1 00:03:20 INFO - Task dependencies: epI30FBeSfGJNJzGhwreow 00:03:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow'}, attempt #1 00:03:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2 00:03:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.test_packages.json 00:03:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.crashreporter-symbols.zip 00:03:20 INFO - Running post-action listener: _resource_record_post_action 00:03:20 INFO - [mozharness: 2017-08-02 07:03:20.843040Z] Finished read-buildbot-config step (success) 00:03:20 INFO - [mozharness: 2017-08-02 07:03:20.843261Z] Running download-and-extract step. 00:03:20 INFO - Running pre-action listener: _resource_record_pre_action 00:03:20 INFO - Running main action method: download_and_extract 00:03:20 INFO - mkdir: /builds/slave/test/build/tests 00:03: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')]} 00:03:20 INFO - trying https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.test_packages.json 00:03:20 INFO - Downloading https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:03:21 INFO - Downloaded 989 bytes. 00:03:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:03:21 INFO - Using the following test package requirements: 00:03:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:03:21 INFO - u'common': [u'target.common.tests.zip'], 00:03:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:03:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:03:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:03:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:03:21 INFO - u'mozbase': [u'target.common.tests.zip'], 00:03:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:03:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:03:21 INFO - u'web-platform': [u'target.common.tests.zip', 00:03:21 INFO - u'target.web-platform.tests.tar.gz'], 00:03:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:03:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 00:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.common.tests.zip 00:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.common.tests.zip into memory 00:03:22 INFO - Content-Length response header: 72391825 00:03:22 INFO - Bytes received: 72391825 00:03:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 00:03:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.common.tests.zip 00:03:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:03:33 INFO - Fetch https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.common.tests.zip into memory 00:03:34 INFO - Content-Length response header: 72391825 00:03:34 INFO - Bytes received: 72391825 00:03:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.talos.tests.zip 00:03:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:03:47 INFO - Fetch https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.talos.tests.zip into memory 00:03:47 INFO - Content-Length response header: 14496467 00:03:47 INFO - Bytes received: 14496467 00:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:48 INFO - trying https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2 00:03:48 INFO - Downloading https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:03:49 INFO - Downloaded 62320797 bytes. 00:03:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2 00:03:49 INFO - mkdir: /builds/slave/test/properties 00:03:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:03:49 INFO - Writing to file /builds/slave/test/properties/build_url 00:03:49 INFO - Contents: 00:03:49 INFO - build_url:https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2 00:03:49 INFO - Running post-action listener: _resource_record_post_action 00:03:49 INFO - Running post-action listener: set_extra_try_arguments 00:03:49 INFO - [mozharness: 2017-08-02 07:03:49.341367Z] Finished download-and-extract step (success) 00:03:49 INFO - [mozharness: 2017-08-02 07:03:49.341464Z] Running populate-webroot step. 00:03:49 INFO - Running pre-action listener: _resource_record_pre_action 00:03:49 INFO - Running main action method: populate_webroot 00:03:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:03:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:03:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:03:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:03:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:03:49 INFO - 'tests': ['damp', 'tps']}, 00:03:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:03:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:03:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:03:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:03:49 INFO - 'other-e10s': {'tests': ['a11yr', 00:03:49 INFO - 'ts_paint', 00:03:49 INFO - 'tpaint', 00:03:49 INFO - 'sessionrestore', 00:03:49 INFO - 'sessionrestore_many_windows', 00:03:49 INFO - 'sessionrestore_no_auto_restore', 00:03:49 INFO - 'tabpaint']}, 00:03:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:03:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:03:49 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:03:49 INFO - 'talos_options': ['--mitmproxy', 00:03:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:03:49 INFO - '--firstNonBlankPaint'], 00:03:49 INFO - 'tests': ['quantum_pageload_google', 00:03:49 INFO - 'quantum_pageload_youtube', 00:03:49 INFO - 'quantum_pageload_amazon', 00:03:49 INFO - 'quantum_pageload_facebook']}, 00:03:49 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:03:49 INFO - 'talos_options': ['--stylo', 00:03:49 INFO - '--mitmproxy', 00:03:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:03:49 INFO - '--firstNonBlankPaint'], 00:03:49 INFO - 'tests': ['quantum_pageload_google', 00:03:49 INFO - 'quantum_pageload_youtube', 00:03:49 INFO - 'quantum_pageload_amazon', 00:03:49 INFO - 'quantum_pageload_facebook']}, 00:03:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:03:49 INFO - 'tsvgr_opacity', 00:03:49 INFO - 'tart', 00:03:49 INFO - 'tscrollx', 00:03:49 INFO - 'cart', 00:03:49 INFO - 'tsvg_static']}, 00:03:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:03:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:03:49 INFO - 'talos_options': ['--stylo', 00:03:49 INFO - '--stylo-threads=1', 00:03:49 INFO - '--mitmproxy', 00:03:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:03:49 INFO - '--firstNonBlankPaint'], 00:03:49 INFO - 'tests': ['tp6_google', 00:03:49 INFO - 'tp6_youtube', 00:03:49 INFO - 'tp6_amazon', 00:03:49 INFO - 'tp6_facebook']}, 00:03:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:03:49 INFO - 'talos_options': ['--xperf_path', 00:03:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:03:49 INFO - 'tests': ['tp5n']}}} 00:03:49 INFO - Running post-action listener: _resource_record_post_action 00:03:49 INFO - [mozharness: 2017-08-02 07:03:49.350106Z] Finished populate-webroot step (success) 00:03:49 INFO - [mozharness: 2017-08-02 07:03:49.350196Z] Running create-virtualenv step. 00:03:49 INFO - Running pre-action listener: _resource_record_pre_action 00:03:49 INFO - Running main action method: create_virtualenv 00:03:49 INFO - Creating virtualenv /builds/slave/test/build/venv 00:03:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:03:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:03:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:03:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:03:49 INFO - Using real prefix '/usr' 00:03:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:03:49 INFO - Installing distribute.............................................................................................................................................................................................done. 00:03:51 INFO - Installing pip.................done. 00:03:51 INFO - Return code: 0 00:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:03:52 INFO - Reading from file tmpfile_stdout 00:03:52 INFO - Output received: 00:03:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:03:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:03:52 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')]} 00:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:52 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')]} 00:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:52 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:03:52 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 00:03:52 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 00:03:52 INFO - Using env: {'DISPLAY': ':0', 00:03:52 INFO - 'HOME': '/home/cltbld', 00:03:52 INFO - 'LANG': 'en_US.UTF-8', 00:03:52 INFO - 'LANGUAGE': 'en_US:en', 00:03:52 INFO - 'LOGNAME': 'cltbld', 00:03:52 INFO - 'MAIL': '/var/mail/cltbld', 00:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:52 INFO - 'MOZ_NO_REMOTE': '1', 00:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:52 INFO - 'NO_EM_RESTART': '1', 00:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:52 INFO - 'PWD': '/builds/slave/test', 00:03:52 INFO - 'SHELL': '/bin/bash', 00:03:52 INFO - 'SHLVL': '1', 00:03:52 INFO - 'TERM': 'linux', 00:03:52 INFO - 'TMOUT': '86400', 00:03:52 INFO - 'USER': 'cltbld', 00:03:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:52 INFO - '_': '/tools/buildbot/bin/python'} 00:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:03:52 INFO - Cleaning up... 00:03:52 INFO - Return code: 0 00:03:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:03:52 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')]} 00:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:52 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')]} 00:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:52 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:03:52 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 00:03:52 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 00:03:52 INFO - Using env: {'DISPLAY': ':0', 00:03:52 INFO - 'HOME': '/home/cltbld', 00:03:52 INFO - 'LANG': 'en_US.UTF-8', 00:03:52 INFO - 'LANGUAGE': 'en_US:en', 00:03:52 INFO - 'LOGNAME': 'cltbld', 00:03:52 INFO - 'MAIL': '/var/mail/cltbld', 00:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:52 INFO - 'MOZ_NO_REMOTE': '1', 00:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:52 INFO - 'NO_EM_RESTART': '1', 00:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:52 INFO - 'PWD': '/builds/slave/test', 00:03:52 INFO - 'SHELL': '/bin/bash', 00:03:52 INFO - 'SHLVL': '1', 00:03:52 INFO - 'TERM': 'linux', 00:03:52 INFO - 'TMOUT': '86400', 00:03:52 INFO - 'USER': 'cltbld', 00:03:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:52 INFO - '_': '/tools/buildbot/bin/python'} 00:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:52 INFO - Downloading/unpacking psutil>=3.1.1 00:03:52 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 00:03:52 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 00:03:52 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 00:03:52 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 00:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:03:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:03:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:03:53 INFO - Installing collected packages: psutil 00:03:53 INFO - Running setup.py install for psutil 00:03:53 INFO - building 'psutil._psutil_linux' extension 00:03:53 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 00:03:53 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 00:03:54 INFO - building 'psutil._psutil_posix' extension 00:03:54 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 00:03:54 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 00:03:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:03:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:03:54 INFO - Successfully installed psutil 00:03:54 INFO - Cleaning up... 00:03:54 INFO - Return code: 0 00:03:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:03:54 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')]} 00:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:54 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')]} 00:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:54 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:03:54 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 00:03:54 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 00:03:54 INFO - Using env: {'DISPLAY': ':0', 00:03:54 INFO - 'HOME': '/home/cltbld', 00:03:54 INFO - 'LANG': 'en_US.UTF-8', 00:03:54 INFO - 'LANGUAGE': 'en_US:en', 00:03:54 INFO - 'LOGNAME': 'cltbld', 00:03:54 INFO - 'MAIL': '/var/mail/cltbld', 00:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:54 INFO - 'MOZ_NO_REMOTE': '1', 00:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:54 INFO - 'NO_EM_RESTART': '1', 00:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:54 INFO - 'PWD': '/builds/slave/test', 00:03:54 INFO - 'SHELL': '/bin/bash', 00:03:54 INFO - 'SHLVL': '1', 00:03:54 INFO - 'TERM': 'linux', 00:03:54 INFO - 'TMOUT': '86400', 00:03:54 INFO - 'USER': 'cltbld', 00:03:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:54 INFO - '_': '/tools/buildbot/bin/python'} 00:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:03:54 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 00:03:54 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 00:03:54 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 00:03:54 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 00:03:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:03:55 INFO - Installing collected packages: mozsystemmonitor 00:03:55 INFO - Running setup.py install for mozsystemmonitor 00:03:55 INFO - Successfully installed mozsystemmonitor 00:03:55 INFO - Cleaning up... 00:03:55 INFO - Return code: 0 00:03:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:03:55 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')]} 00:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:55 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')]} 00:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:55 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:03:55 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 00:03:55 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 00:03:55 INFO - Using env: {'DISPLAY': ':0', 00:03:55 INFO - 'HOME': '/home/cltbld', 00:03:55 INFO - 'LANG': 'en_US.UTF-8', 00:03:55 INFO - 'LANGUAGE': 'en_US:en', 00:03:55 INFO - 'LOGNAME': 'cltbld', 00:03:55 INFO - 'MAIL': '/var/mail/cltbld', 00:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:55 INFO - 'MOZ_NO_REMOTE': '1', 00:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:55 INFO - 'NO_EM_RESTART': '1', 00:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:55 INFO - 'PWD': '/builds/slave/test', 00:03:55 INFO - 'SHELL': '/bin/bash', 00:03:55 INFO - 'SHLVL': '1', 00:03:55 INFO - 'TERM': 'linux', 00:03:55 INFO - 'TMOUT': '86400', 00:03:55 INFO - 'USER': 'cltbld', 00:03:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:55 INFO - '_': '/tools/buildbot/bin/python'} 00:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:56 INFO - Downloading/unpacking jsonschema==2.5.1 00:03:56 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 00:03:56 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 00:03:56 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 00:03:56 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 00:03:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:03:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:03:57 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 00:03:57 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 00:03:57 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 00:03:57 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 00:03:57 INFO - Downloading functools32-3.2.3-2.tar.gz 00:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:03:57 INFO - warning: no files found matching '*.txt' 00:03:57 INFO - no previously-included directories found matching 'build' 00:03:57 INFO - no previously-included directories found matching 'dist' 00:03:57 INFO - no previously-included directories found matching '.git*' 00:03:57 INFO - Installing collected packages: jsonschema, functools32 00:03:57 INFO - Running setup.py install for functools32 00:03:57 INFO - warning: no files found matching '*.txt' 00:03:57 INFO - no previously-included directories found matching 'build' 00:03:57 INFO - no previously-included directories found matching 'dist' 00:03:57 INFO - no previously-included directories found matching '.git*' 00:03:57 INFO - Successfully installed jsonschema functools32 00:03:57 INFO - Cleaning up... 00:03:57 INFO - Return code: 0 00:03:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:03:57 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')]} 00:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:57 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')]} 00:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:57 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:03:57 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 00:03:57 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 00:03:57 INFO - Using env: {'DISPLAY': ':0', 00:03:57 INFO - 'HOME': '/home/cltbld', 00:03:57 INFO - 'LANG': 'en_US.UTF-8', 00:03:57 INFO - 'LANGUAGE': 'en_US:en', 00:03:57 INFO - 'LOGNAME': 'cltbld', 00:03:57 INFO - 'MAIL': '/var/mail/cltbld', 00:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:57 INFO - 'MOZ_NO_REMOTE': '1', 00:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:57 INFO - 'NO_EM_RESTART': '1', 00:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:57 INFO - 'PWD': '/builds/slave/test', 00:03:57 INFO - 'SHELL': '/bin/bash', 00:03:57 INFO - 'SHLVL': '1', 00:03:57 INFO - 'TERM': 'linux', 00:03:57 INFO - 'TMOUT': '86400', 00:03:57 INFO - 'USER': 'cltbld', 00:03:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:57 INFO - '_': '/tools/buildbot/bin/python'} 00:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:03:57 INFO - Cleaning up... 00:03:57 INFO - Return code: 0 00:03:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:03:57 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')]} 00:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:57 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')]} 00:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:57 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:03:57 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 00:03:57 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 00:03:57 INFO - Using env: {'DISPLAY': ':0', 00:03:57 INFO - 'HOME': '/home/cltbld', 00:03:57 INFO - 'LANG': 'en_US.UTF-8', 00:03:57 INFO - 'LANGUAGE': 'en_US:en', 00:03:57 INFO - 'LOGNAME': 'cltbld', 00:03:57 INFO - 'MAIL': '/var/mail/cltbld', 00:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:57 INFO - 'MOZ_NO_REMOTE': '1', 00:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:57 INFO - 'NO_EM_RESTART': '1', 00:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:57 INFO - 'PWD': '/builds/slave/test', 00:03:57 INFO - 'SHELL': '/bin/bash', 00:03:57 INFO - 'SHLVL': '1', 00:03:57 INFO - 'TERM': 'linux', 00:03:57 INFO - 'TMOUT': '86400', 00:03:57 INFO - 'USER': 'cltbld', 00:03:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:57 INFO - '_': '/tools/buildbot/bin/python'} 00:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:57 INFO - Downloading/unpacking blobuploader==1.2.4 00:03:57 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 00:03:57 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 00:03:57 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 00:03:57 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 00:03:59 INFO - Downloading blobuploader-1.2.4.tar.gz 00:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:03:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:03:59 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 00:03:59 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 00:03:59 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 00:03:59 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 00:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:03:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:03:59 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 00:03:59 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 00:03:59 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 00:03:59 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 00:03:59 INFO - Downloading docopt-0.6.1.tar.gz 00:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:03:59 INFO - Installing collected packages: blobuploader, requests, docopt 00:03:59 INFO - Running setup.py install for blobuploader 00:03:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:03:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:03:59 INFO - Running setup.py install for requests 00:04:00 INFO - Running setup.py install for docopt 00:04:00 INFO - Successfully installed blobuploader requests docopt 00:04:00 INFO - Cleaning up... 00:04:00 INFO - Return code: 0 00:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:00 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:04:00 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 00:04:00 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 00:04:00 INFO - Using env: {'DISPLAY': ':0', 00:04:00 INFO - 'HOME': '/home/cltbld', 00:04:00 INFO - 'LANG': 'en_US.UTF-8', 00:04:00 INFO - 'LANGUAGE': 'en_US:en', 00:04:00 INFO - 'LOGNAME': 'cltbld', 00:04:00 INFO - 'MAIL': '/var/mail/cltbld', 00:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:00 INFO - 'MOZ_NO_REMOTE': '1', 00:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:00 INFO - 'NO_EM_RESTART': '1', 00:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:00 INFO - 'PWD': '/builds/slave/test', 00:04:00 INFO - 'SHELL': '/bin/bash', 00:04:00 INFO - 'SHLVL': '1', 00:04:00 INFO - 'TERM': 'linux', 00:04:00 INFO - 'TMOUT': '86400', 00:04:00 INFO - 'USER': 'cltbld', 00:04:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:00 INFO - '_': '/tools/buildbot/bin/python'} 00:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:04:00 INFO - Running setup.py (path:/tmp/pip-owqgh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:04:00 INFO - Running setup.py (path:/tmp/pip-bcFuZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:04:00 INFO - Running setup.py (path:/tmp/pip-dPdXBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:04:00 INFO - Running setup.py (path:/tmp/pip-fpl54h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:04:00 INFO - Running setup.py (path:/tmp/pip-3U8kuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:04:00 INFO - Running setup.py (path:/tmp/pip-i9aUUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:04:00 INFO - Running setup.py (path:/tmp/pip-M93Qz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:04:00 INFO - Running setup.py (path:/tmp/pip-_e3GWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:04:00 INFO - Running setup.py (path:/tmp/pip-3YOaEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:04:01 INFO - Running setup.py (path:/tmp/pip-cABziy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:04:01 INFO - Running setup.py (path:/tmp/pip-mtLgpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:04:01 INFO - Running setup.py (path:/tmp/pip-mETg0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:04:01 INFO - Running setup.py (path:/tmp/pip-V85Snu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:04:01 INFO - Running setup.py (path:/tmp/pip-e4KS7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:01 INFO - Running setup.py (path:/tmp/pip-Btzrb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:04:01 INFO - Running setup.py (path:/tmp/pip-N01yKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:04:01 INFO - Running setup.py (path:/tmp/pip-2NxPoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:04:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:04:01 INFO - Running setup.py install for manifestparser 00:04:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:04:01 INFO - Running setup.py install for mozcrash 00:04:01 INFO - Running setup.py install for mozdebug 00:04:01 INFO - Running setup.py install for mozdevice 00:04:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Running setup.py install for mozfile 00:04:02 INFO - Running setup.py install for mozhttpd 00:04:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Running setup.py install for mozinfo 00:04:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Running setup.py install for mozInstall 00:04:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Running setup.py install for mozleak 00:04:02 INFO - Running setup.py install for mozlog 00:04:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Running setup.py install for moznetwork 00:04:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Running setup.py install for mozprocess 00:04:02 INFO - Running setup.py install for mozprofile 00:04:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:04:02 INFO - Running setup.py install for mozrunner 00:04:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:04:03 INFO - Running setup.py install for mozscreenshot 00:04:03 INFO - Running setup.py install for moztest 00:04:03 INFO - Running setup.py install for mozversion 00:04:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:04:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:04:03 INFO - Cleaning up... 00:04:03 INFO - Return code: 0 00:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:04:03 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')]} 00:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:03 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')]} 00:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:03 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:04:03 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 00:04:03 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 00:04:03 INFO - Using env: {'DISPLAY': ':0', 00:04:03 INFO - 'HOME': '/home/cltbld', 00:04:03 INFO - 'LANG': 'en_US.UTF-8', 00:04:03 INFO - 'LANGUAGE': 'en_US:en', 00:04:03 INFO - 'LOGNAME': 'cltbld', 00:04:03 INFO - 'MAIL': '/var/mail/cltbld', 00:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:03 INFO - 'MOZ_NO_REMOTE': '1', 00:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:03 INFO - 'NO_EM_RESTART': '1', 00:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:03 INFO - 'PWD': '/builds/slave/test', 00:04:03 INFO - 'SHELL': '/bin/bash', 00:04:03 INFO - 'SHLVL': '1', 00:04:03 INFO - 'TERM': 'linux', 00:04:03 INFO - 'TMOUT': '86400', 00:04:03 INFO - 'USER': 'cltbld', 00:04:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:03 INFO - '_': '/tools/buildbot/bin/python'} 00:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:04:03 INFO - Running setup.py (path:/tmp/pip-r7xPXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:04:03 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)) 00:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:04:03 INFO - Running setup.py (path:/tmp/pip-JXeLVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:04:03 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)) 00:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:04:03 INFO - Running setup.py (path:/tmp/pip-9u2VkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:04:03 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)) 00:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:04:03 INFO - Running setup.py (path:/tmp/pip-DW1cOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:04:03 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)) 00:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:04:03 INFO - Running setup.py (path:/tmp/pip-ZMyT72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:04:04 INFO - Running setup.py (path:/tmp/pip-biLHjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:04:04 INFO - Running setup.py (path:/tmp/pip-6NQMfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:04:04 INFO - Running setup.py (path:/tmp/pip-fo_rDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:04:04 INFO - Running setup.py (path:/tmp/pip-_wz_7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:04:04 INFO - Running setup.py (path:/tmp/pip-tM17xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:04:04 INFO - Running setup.py (path:/tmp/pip-OQ95nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:04:04 INFO - Running setup.py (path:/tmp/pip-TSWaIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:04:04 INFO - Running setup.py (path:/tmp/pip-BZv00A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:04:04 INFO - Running setup.py (path:/tmp/pip-5lCXcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:04 INFO - Running setup.py (path:/tmp/pip-64EiWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:04:04 INFO - Running setup.py (path:/tmp/pip-svgnX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:04:04 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)) 00:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:04:04 INFO - Running setup.py (path:/tmp/pip-FoXuS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:04:04 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)) 00:04:04 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)) 00:04:04 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)) 00:04:04 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)) 00:04:04 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)) 00:04:04 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)) 00:04:04 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)) 00:04:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:04:04 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 00:04:04 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 00:04:04 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 00:04:04 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 00:04:05 INFO - Downloading blessings-1.6.tar.gz 00:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:04:06 INFO - Installing collected packages: blessings 00:04:06 INFO - Running setup.py install for blessings 00:04:06 INFO - Successfully installed blessings 00:04:06 INFO - Cleaning up... 00:04:06 INFO - Return code: 0 00:04:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:04:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:04:06 INFO - Reading from file tmpfile_stdout 00:04:06 INFO - Current package versions: 00:04:06 INFO - argparse == 1.2.1 00:04:06 INFO - blessings == 1.6 00:04:06 INFO - blobuploader == 1.2.4 00:04:06 INFO - docopt == 0.6.1 00:04:06 INFO - functools32 == 3.2.3-2 00:04:06 INFO - jsonschema == 2.5.1 00:04:06 INFO - manifestparser == 1.1 00:04:06 INFO - mozInstall == 1.13 00:04:06 INFO - mozcrash == 1.0 00:04:06 INFO - mozdebug == 0.1 00:04:06 INFO - mozdevice == 0.51 00:04:06 INFO - mozfile == 1.2 00:04:06 INFO - mozhttpd == 0.7 00:04:06 INFO - mozinfo == 0.10 00:04:06 INFO - mozleak == 0.1 00:04:06 INFO - mozlog == 3.5 00:04:06 INFO - moznetwork == 0.27 00:04:06 INFO - mozprocess == 0.25 00:04:06 INFO - mozprofile == 0.28 00:04:06 INFO - mozrunner == 6.13 00:04:06 INFO - mozscreenshot == 0.1 00:04:06 INFO - mozsystemmonitor == 0.3 00:04:06 INFO - moztest == 0.8 00:04:06 INFO - mozversion == 1.4 00:04:06 INFO - psutil == 3.1.1 00:04:06 INFO - requests == 1.2.3 00:04:06 INFO - wsgiref == 0.1.2 00:04:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:04:06 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')]} 00:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:06 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')]} 00:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:06 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:04:06 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 00:04:06 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 00:04:06 INFO - Using env: {'DISPLAY': ':0', 00:04:06 INFO - 'HOME': '/home/cltbld', 00:04:06 INFO - 'LANG': 'en_US.UTF-8', 00:04:06 INFO - 'LANGUAGE': 'en_US:en', 00:04:06 INFO - 'LOGNAME': 'cltbld', 00:04:06 INFO - 'MAIL': '/var/mail/cltbld', 00:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:06 INFO - 'MOZ_NO_REMOTE': '1', 00:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:06 INFO - 'NO_EM_RESTART': '1', 00:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:06 INFO - 'PWD': '/builds/slave/test', 00:04:06 INFO - 'SHELL': '/bin/bash', 00:04:06 INFO - 'SHLVL': '1', 00:04:06 INFO - 'TERM': 'linux', 00:04:06 INFO - 'TMOUT': '86400', 00:04:06 INFO - 'USER': 'cltbld', 00:04:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:06 INFO - '_': '/tools/buildbot/bin/python'} 00:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:06 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)) 00:04:06 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)) 00:04:06 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)) 00:04:06 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)) 00:04:06 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)) 00:04:06 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)) 00:04:06 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)) 00:04:06 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)) 00:04:06 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)) 00:04:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:04:06 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 00:04:06 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 00:04:06 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 00:04:06 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 00:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:04:07 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)) 00:04:07 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)) 00:04:07 INFO - Installing collected packages: simplejson 00:04:07 INFO - Running setup.py install for simplejson 00:04:07 INFO - building 'simplejson._speedups' extension 00:04:07 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 00:04:08 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 00:04:08 INFO - Successfully installed simplejson 00:04:08 INFO - Cleaning up... 00:04:08 INFO - Return code: 0 00:04:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:04: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')]} 00:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04: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')]} 00:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:08 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 0xf271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', '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 00:04:08 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 00:04:08 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 00:04:08 INFO - Using env: {'DISPLAY': ':0', 00:04:08 INFO - 'HOME': '/home/cltbld', 00:04:08 INFO - 'LANG': 'en_US.UTF-8', 00:04:08 INFO - 'LANGUAGE': 'en_US:en', 00:04:08 INFO - 'LOGNAME': 'cltbld', 00:04:08 INFO - 'MAIL': '/var/mail/cltbld', 00:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:08 INFO - 'MOZ_NO_REMOTE': '1', 00:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:08 INFO - 'NO_EM_RESTART': '1', 00:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:08 INFO - 'PWD': '/builds/slave/test', 00:04:08 INFO - 'SHELL': '/bin/bash', 00:04:08 INFO - 'SHLVL': '1', 00:04:08 INFO - 'TERM': 'linux', 00:04:08 INFO - 'TMOUT': '86400', 00:04:08 INFO - 'USER': 'cltbld', 00:04:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:08 INFO - '_': '/tools/buildbot/bin/python'} 00:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:04:09 INFO - Cleaning up... 00:04:09 INFO - Return code: 0 00:04:09 INFO - Running post-action listener: _resource_record_post_action 00:04:09 INFO - Running post-action listener: _start_resource_monitoring 00:04:09 INFO - Starting resource monitoring. 00:04:09 INFO - [mozharness: 2017-08-02 07:04:09.090841Z] Finished create-virtualenv step (success) 00:04:09 INFO - [mozharness: 2017-08-02 07:04:09.091350Z] Running install step. 00:04:09 INFO - Running pre-action listener: _resource_record_pre_action 00:04:09 INFO - Running main action method: install 00:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:04:09 INFO - Reading from file tmpfile_stdout 00:04:09 INFO - Detecting whether we're running mozinstall >=1.0... 00:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:04:09 INFO - Reading from file tmpfile_stdout 00:04:09 INFO - Output received: 00:04:09 INFO - Usage: mozinstall [options] installer 00:04:09 INFO - Options: 00:04:09 INFO - -h, --help show this help message and exit 00:04:09 INFO - -d DEST, --destination=DEST 00:04:09 INFO - Directory to install application into. [default: 00:04:09 INFO - "/builds/slave/test"] 00:04:09 INFO - --app=APP Application being installed. [default: firefox] 00:04:09 INFO - mkdir: /builds/slave/test/build/application 00:04:09 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'] 00:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:04:27 INFO - Reading from file tmpfile_stdout 00:04:27 INFO - Output received: 00:04:27 INFO - /builds/slave/test/build/application/firefox/firefox 00:04:27 INFO - Running post-action listener: _resource_record_post_action 00:04:27 INFO - [mozharness: 2017-08-02 07:04:27.505415Z] Finished install step (success) 00:04:27 INFO - [mozharness: 2017-08-02 07:04:27.505678Z] Running setup-mitmproxy step. 00:04:27 INFO - Running pre-action listener: _resource_record_pre_action 00:04:27 INFO - Running main action method: setup_mitmproxy 00:04:27 INFO - Skipping: mitmproxy is not required 00:04:27 INFO - Running post-action listener: _resource_record_post_action 00:04:27 INFO - [mozharness: 2017-08-02 07:04:27.506812Z] Finished setup-mitmproxy step (success) 00:04:27 INFO - [mozharness: 2017-08-02 07:04:27.507032Z] Running run-tests step. 00:04:27 INFO - Running pre-action listener: _resource_record_pre_action 00:04:27 INFO - Running pre-action listener: _set_gcov_prefix 00:04:27 INFO - Running main action method: run_tests 00:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:04:27 INFO - Python 2.7.3 00:04:27 INFO - Return code: 0 00:04:27 INFO - grabbing minidump binary from tooltool 00:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:04:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1293eb0>, '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 0x1294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1295240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:04:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:04:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:04:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:04:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:04:27 INFO - Return code: 0 00:04:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:04:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:04:27 INFO - ENV: RUST_BACKTRACE is now 1 00:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 00:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 00:04:27 INFO - Using env: {'DISPLAY': ':0', 00:04:27 INFO - 'HOME': '/home/cltbld', 00:04:27 INFO - 'LANG': 'en_US.UTF-8', 00:04:27 INFO - 'LANGUAGE': 'en_US:en', 00:04:27 INFO - 'LOGNAME': 'cltbld', 00:04:27 INFO - 'MAIL': '/var/mail/cltbld', 00:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:27 INFO - 'MOZ_NO_REMOTE': '1', 00:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:27 INFO - 'NO_EM_RESTART': '1', 00:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:27 INFO - 'PWD': '/builds/slave/test', 00:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:04:27 INFO - 'RUST_BACKTRACE': '1', 00:04:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:04:27 INFO - 'SHELL': '/bin/bash', 00:04:27 INFO - 'SHLVL': '1', 00:04:27 INFO - 'STYLO_FORCE_ENABLED': '1', 00:04:27 INFO - 'TERM': 'linux', 00:04:27 INFO - 'TMOUT': '86400', 00:04:27 INFO - 'USER': 'cltbld', 00:04:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414', 00:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:27 INFO - '_': '/tools/buildbot/bin/python'} 00:04:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 00:04:27 INFO - mozversion application_buildid: 20170802061910 00:04:27 INFO - mozversion application_changeset: 320642944e42a889db13c6c55b404e32319d4de6 00:04:27 INFO - mozversion application_display_name: Nightly 00:04:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:04:27 INFO - mozversion application_name: Firefox 00:04:27 INFO - mozversion application_remotingname: firefox 00:04:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:04:27 INFO - mozversion application_vendor: Mozilla 00:04:27 INFO - mozversion application_version: 56.0a1 00:04:27 INFO - mozversion platform_buildid: 20170802061910 00:04:27 INFO - mozversion platform_changeset: 320642944e42a889db13c6c55b404e32319d4de6 00:04:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:04:27 INFO - mozversion platform_version: 56.0a1 00:04:27 INFO - using testdate: 1501657467 00:04:27 INFO - actual date: 1501657467 00:04:27 INFO - starting webserver on 'localhost:56048' 00:04:27 INFO - SUITE-START | Running 2 tests 00:04:27 INFO - TEST-START | dromaeo_css 00:04:27 INFO - Initialising browser for dromaeo_css test... 00:04:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56048/getInfo.html -profile /tmp/tmptFB4yB/profile 00:04:27 INFO - TEST-INFO | started process 15169 (/builds/slave/test/build/application/firefox/firefox http://localhost:56048/getInfo.html) 00:04:33 INFO - TEST-INFO | 15169: exit 0 00:04:34 INFO - Browser initialized. 00:04:34 INFO - Running cycle 1/1 for dromaeo_css test... 00:04:34 INFO - TEST-INFO | started process 15392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptFB4yB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:04:35 INFO - PID 15392 | 00:04:35 INFO - PID 15392 | (/builds/slave/test/build/application/firefox/firefox:15446): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:04:35 INFO - PID 15392 | 00:04:45 INFO - PID 15392 | RSS: Main: 174956544 00:04:45 INFO - PID 15392 | 00:07:44 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:56048/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56048/tests/dromaeo/cssquery-ext.html) 00:07:45 INFO - PID 15392 | RSS: Main: 173760512 00:07:45 INFO - PID 15392 | 00:10:47 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:56048/tests/dromaeo/cssquery-ext.html (next: http://localhost:56048/tests/dromaeo/cssquery-jquery.html) 00:10:48 INFO - PID 15392 | RSS: Main: 174084096 00:10:48 INFO - PID 15392 | 00:13:50 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:56048/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56048/tests/dromaeo/cssquery-mootools.html) 00:13:50 INFO - PID 15392 | RSS: Main: 174710784 00:13:50 INFO - PID 15392 | 00:16:52 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:56048/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56048/tests/dromaeo/cssquery-prototype.html) 00:16:53 INFO - PID 15392 | RSS: Main: 174592000 00:16:53 INFO - PID 15392 | 00:19:57 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:56048/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56048/tests/dromaeo/cssquery-yui.html) 00:19:57 INFO - PID 15392 | RSS: Main: 177131520 00:19:57 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:56048/tests/dromaeo/cssquery-yui.html (next: http://localhost:56048/tests/dromaeo/cssquery-dojo.html) 00:22:59 INFO - PID 15392 | RSS: Main: 180244480 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | __start_tp_report 00:22:59 INFO - PID 15392 | _x_x_mozilla_page_load 00:22:59 INFO - PID 15392 | _x_x_mozilla_page_load_details 00:22:59 INFO - PID 15392 | |i|pagename|runs| 00:22:59 INFO - PID 15392 | |0;dojo.html;3103.5034394496897;3150.2911844834916;3154.495280755079;3158.652548219694;3192.888248911288;6110.052941794023;6217.62694238346;6246.09431632413;6270.27891792444;6287.874242515159;6023.608465449743;6113.938860611393;6115.663638499881;6147.0472076828055;6172.321044685081;5585;5608.5793565482545;5609.3268807743125;5627.971860140704;5633.408492108331;5645.943540564583;5673.659580425167;5686.914696279559;5734.97132514339;5793.246877905866;5642.689652069134;5705.087186050233;5705.5435565154685;5714.914276285859;5726.942730572682;5423.538999185074;5488.588355873326;5536.916946245809;5563.304586926634;5638;5573.721313934328;5584.86037849053;5616.971915140398;5621.494065534122;5632;6040.395960403968;6074.088886666991;6090.147379366892;6133.325334213233;6141.140240366352;6566.409023187936;6584.868302633969;6627.105340778981;6668.966655166693;6670.866582668319;6742.696578653972;6757.155355580552;6774.69513871872;6785.762498312584;6809.080774095532;6184.350643182446;6186.319504854418;6229.345918678564;6270.372962703739;6301.149344838388;6844.863102738017;6867.038614593961;6945.89581156283;6960.512764106464;6964.825879353057;6428;6489;6521.413072823469;6526.543141980016;6596.736130554724;6622.205335359788;6640.867182656417;6682.83292917681;6716.361945615159;6724.529282950244;6565.376289252514;6600.207975043026;6654.500912431587;6681.532292739559;6700.329967003261;6535.607863528204;6636.30318816527;6672.966635166793;6677.833054173588;6708.060871477997;5455.072637651609;5463.125899856083;5490.780368785284;5494.642848214853;5495.34055913285;4605.631549476034;4630.073985202973;4644.2801365788355;4660.044690838437;4673.439187297546;5693.516051135617;5735.598508104393;5765.827025189251;5793.420657934257;5807.157962095473;6611.074449577063;6681.298463661343;6705.094812200388;6726;6730.427913627299;5627.774889004476;5736.68448235351;5746.195532625436;5751.424857514216;5776.56675749312;5877.147813567009;5891.558133140032;5897.439743224387;5901.704914754245;5919.67441790697;6425.935740642627;6441.355864413521;6448.193975753031;6454;6456.806295811133;6624.138861947916;6647.933520664731;6656.400923916871;6661.300563440963;6668.499862510234;6345.587536810092;6354;6452.225732911893;6461.38616831419;6481.060246264359;6516.348365163635;6530.738770449128;6555.541112122296;6565.934340656532;6585.913324301437;6581.868362632817;6614.768483103068;6724.630145342053;6727.798166055026;6738.764143254963;6402.327755585783;6430.807075787734;6516.826971145239;6525.3148419417175;6529.575577587631;6365.108884756045;6410.1987251593555;6474.4820414365795;6482.773102941374;6527.771527996498;6349.746010159727;6409.9359006411205;6414.679266036586;6415.133956915944;6421.871562568629;6396.584222025554;6441.1626488556185;6509.8698026040165;6514.57655252407;6533.640649764308;6225.28409232944;6253.343398943228;6285.43431091204;6325.683715814283;6337.334579869047 00:22:59 INFO - PID 15392 | |1;ext.html;807.9353651707864;876.2945828607972;901.4140808474491;906.9093090690927;1134.9716257093576;30257.546136807938;40351.19297614046;40476.59523404769;40521.79739101304;40523.189536209255;40050.19899602013;40416.79791601045;40436.393454098135;40530.59469405305;40618.79690601543;7048.471364647647;7424.740134095294;7561.357284630813;7584.4690871639;7604.619769011555;7480.62596870157;7500.137484189307;7623.313901748841;7625;7625.466217364787;7497.212792656775;7638.809029774272;7642.312191902728;7642.617869106551;7668.501547399401;7531.698732050711;7574.734884279052;7588.544687318723;7591.8861217081785;7593.886091708629;7401.444891633149;7425.925740742631;7486.101667799844;7491.587962662052;7491.625418729096;37691.24617507635;37887.81056094702;38039.23921521554;38298.42552361717;38315;3571.357155711971;3596.496490491333;3609.5668519777796;3616.132128289218;3621;30389;30461.695383046328;30490.54264186039;30577.38845223083;30613.540796888065;4923.064617722621;4936.950630493685;4949.208126699711;4971.328870602495;5046.09170349337;195551;196915.99999999857;196937;197236;197557;48403.515964840604;48540.844845084954;48554;48758;48780;50908.745456273224;51466.228006579186;51511;51579.74210128925;51599;15708.764368534481;15797;15806.130662813655;15848.128352940468;15901.920490397473;10727.570897164025;10874.67375978722;10911.618093366853;12721.745565088646;12968.09223354375;14048.789268160986;14095.154290742588;14096.02655628213;14119.152850828983;14205.78691319631;5600.267773731191;5749.051406517961;5800.564957628195;5849.444302791228;5940.792072277536;981.5435822342645;1006.5319626373771;1014.8477728340808;1023.2223510132204;1027.9331843430152;22448.214312498985;22569.548609027726;22674.886625566767;23266.53466930652;29116.41767164645;1082.426314053553;1084.7830433913248;1104.5250542266901;1106.0819519798547;1108.4070022537903;12027.338496382783;12328;12418.316992565315;12474.875251247371;12478.81281780774;243372;243809;243888;245450;245544;49057.2641410372;49187.75406122946;49394.259086113736;49567;49812.501874980786;1444.3789170656507;1462.978055329171;1499.2803454341977;1502.361496364041;1504.5636765338147;22456.66315005309;22607.208747693752;22658.43353916165;22830.31509054731;22880.771192287863;36391.818040909624;36638;36683.63316366909;36696.449553257255;36713.44929826001;213755;215527;215797;216120;216222;29726.851365743034;29954.85022574873;29983.250418738833;33010.17474563059;33052.66947330496;41976.1604767909;42052.36921446119;42413.78793106015;42723.7863810679;43335;31124.22189445282;31656.208594785316;31707.841460792548;31741.365172695954;31854.840725796224;30741.538876916416;31121.377572448877;31203.531947020358;31389.116653000892;32123;34656.78701245444;34673.826630866686;34894.476582851785;34998.47502287417;37300.253994920495;32626.83686581552;33300;33510.99467015993;33606.159846003065;33767.15582110467;23752.88123559371;23926;24074.39814004664;24817.25548233556;25263.87368063148 00:22:59 INFO - PID 15392 | |2;jquery.html;584.4068270705235;588.5379976718276;590.530528230057;596.6777939912447;601.8044135655913;16113.516594502154;21868.343949681515;22760.43098922528;22849.42876428086;22849.657255141166;18818;18931.62136757264;19354.322598709048;19670.409887703358;24532.877335613342;6330.588511746733;6551.246606640249;6558.508111891603;6583.111279977214;6592;6327.1458353122425;6441.645709485976;6487.448566871822;6489;6497.837554061139;5852.180694702745;6442.6134431934;6447.451966582846;6451.516136289773;6465.3534646535445;6377.936220637804;6385.138006369174;6393.200849893763;6413.102165696783;6432.839179020515;5969.432903874125;5971.552133589955;5977;5979.372165922559;5995.880082398327;27118.5932211017;27732.722672773416;27783.166505004883;28440.431191376058;28491.430171396456;1839.5401149712573;1890.962180756391;1891.4231159496348;1891.4231159496348;1892.0634286028503;18718.251269949185;18961.336353227707;18996.145173467226;19023.429297121107;19060.428187154408;2160.2223199648115;2215.9446013849783;2220.2340192633515;2224.9666255006186;2238.9888050559807;126421;132685;133445;138083;142985.57014429825;14510.069168448195;14743.410263589336;14744.926275368554;14960.027598206081;15005.920234211346;23138;23187;23195.53608927812;23228.606283623038;23273.534529309658;9850.950745246371;9904.15814655748;10015.899841001643;10058.34620749649;10065.899341006643;9218.468918648758;9312.767180820534;9356.27103120092;9369.484678342757;9439.716808495756;9175.77060573491;9176.6788162414;9265;9387.90612093884;9390.060993900555;2639.947201055968;2666.8266562673366;2687.193841847438;2714.0907795888597;2771.8336899786077;942.1426501883253;969.520087556664;977.452626529146;983.179045497018;993.0218734546465;19145.13846876894;23751.287461376185;23752.06578659165;23945.760542394702;24614.538821001363;1027.4041056187393;1039.262123892045;1042.5040067503157;1053.9683809485575;1055.7430327439934;10473.583793664942;11082.445877706083;12915.935420323027;13867.583972480841;13949.790753138712;503414;530503;536575;548084;548409;123385;127381.36309318579;127958.36020819837;128064.35967820101;132204;1232.975340493185;1256.773780719461;1294.527497463419;1295.0416691648113;1317.3544962968076;20549.691754623993;20647.690284646043;21223.363299101053;21611.783882160977;21635.567288654453;57757.42242577521;60701.0894836569;62036.68981655063;62591.6870415645;62793.68603156955;77344.22655773371;77345.61327193328;77884;78261.60869195618;79040;20123.698144528138;20283.492912677302;20483.87338696386;20565.354771617935;20826.1669533217;22834.771652283263;23078.769212308332;23243.186488472824;23379.88310058439;23548.6467702988;17968.550786230448;18042;18142.5464363392;18383.90808045951;18427.539311516783;16513.66972660564;16612.916935415247;16778.1610919456;17126.74309885328;17341.046242456785;18563.164657590172;18669.346572869883;18738;18800.965946872508;18900.432987010412;19623.11695973713;20071;21037;21042;21046.68429973521;18216.089195539906;18489.630207396047;18490.16794244289;18509.907450462662;18675.252989880253 00:22:59 INFO - PID 15392 | |3;mootools.html;1353.0934274036397;1390.2423179367245;1406.226575383539;1416.5821082780578;1418.4609848257667;13284.601461956157;13341.199528028314;13915.44338226471;13940.44238230471;13942.302884855742;13762.862371376283;14052.789208161887;14054.367553460093;14054.718905621881;14057.929710351435;2675.545157323255;2742.245882382351;2743.1770468859363;2744.821586596875;2745.835249885013;2627.2512333984723;2724.7547720705134;2791.6091747155415;2802.565602331642;2816.1833068410137;2705.161399966007;2725.3459169799203;2748.9862550687217;2750.1612008337447;2754.944901101987;2688.4085501189707;2688.6504754382;2705.8917643294244;2733.098077634386;2742.081402730068;2542.9109981150573;2550.5919052951626;2607.087519368206;2646.629471873939;2652.655154829879;13498.730025399534;13523.188608683511;13567.05030647855;13573.796393054112;13627.182369057888;7361.595112268823;7572.053493313336;7576.696932122763;7616.504927179715;7638;4935.3090567320605;5133.512316329943;5211.2443695663915;5274.182501712241;5386.622936394454;1741.364401993276;1816.0828781465407;1818.945431637053;1843.944681659539;1854.1470923375264;21694.240701575527;21915.452113697283;21979.560408791735;22621.321360359216;22627.20804771825;6321.241451025814;6500.667363190534;6517.315681853432;6721.462283017347;6821;14893.627659308604;14938.626534336729;14941.775873361908;14958.252087395587;14965.102093874402;7317.341439270384;7425.9628701856145;7435.665395057127;7437.181909989897;7438.516496427715;6739.191297044386;6792.762253321209;6836.555623884432;6876.965615171992;6896.241413444517;4997.750112494361;5118.334616499831;5166.095933211673;5216.165413533817;5263.105272103751;1388.2364699415282;1421.1118051217989;1424.3163281624877;1425.836028856674;1432.0548438031058;886.7073865624328;917.6467060181744;925.4817302310728;928.726025822384;937.2876613773581;7036.92963070373;7076.929230707627;7104.609246491389;7130.893036604455;7242.3843973262865;725.4232884856551;728.613834667627;730.3901242462604;730.7077169132283;732.2348146187247;4961.107000739901;5101.158308879068;5154.819581314636;5238.083335416287;5307.097793375136;17900.641987160183;18289.817101829078;18294.817051829577;18444.81555184458;18546.721799173025;17194.570135746457;18243.27026918935;18784.62430751377;18799.812001879807;18808.81191188098;9599.616015359446;10271.537780799881;10324.483775811179;10327.173826093895;10334.069933706003;8013.6794528218215;8215.096339402542;8300.12848650883;8413.747587572383;8807.823843523222;16213.756793648341;16329.591760206089;16365.754513682066;16642.916785415997;16689.833101668828;15764.369425222863;16155.353785848434;16305.67388652244;16469.83530164683;16605.91697041507;10871.239013268996;11095.944520277348;11148.777024459303;11150.553977840795;11158;12305.507779688713;12500.187487813264;12516;12660.493580257054;12748.681282968;10005.499725013575;10029.097381235724;10273;10318.742031449274;10481.42352170638;10130.08829205375;10154.136898363426;10286.074253317238;10329.638462653771;10427.061564459234;9070;9236.030216827136;9291.62833486653;9292.303077269096;9294.814103717752;7015.123109611299;7141.678624461808;7156.749513766993;7231.63841807918;7256.528325658815;7150.463715221484;7266.091738532684;7276.4542659299705;7333.633318333956;7370.705171793283 00:22:59 INFO - PID 15392 | |4;prototype.html;497.43060643669213;507.13027158423296;515.6081378152604;523.5628250410907;531.4287141323078;6213.720382582784;6223.875522489548;6229.532785041129;6244.500439964803;6282.277538083122;5793.913091303634;5977.462028417442;6010.248718910137;6064.9696751516185;6112.449879510854;4894.143524883149;4909.263610458442;4928.728919909404;4950.504949505057;5006.624503162259;4858.392700912386;4892.119418504668;4930.161872481687;4930.704157750529;4966.5778408835295;4711.764411779414;4839.032193561302;4841.225403935371;4864.513548645143;4921.360223170983;4817.710937343771;4848.587870031051;4882.829100981484;4884.096442158212;4900.6569540132205;4364.672649551297;4375.7155784873885;4383.364412160251;4389.363542286383;4415.2935530315;5836.445537673914;5926.4073592640825;5981.342052374235;6012.398760123996;6037.849053773691;5574.414686457904;5576.749046292886;5596.496315331599;5613.915791263134;5629.057974998619;6523.151990241238;6524.869502609969;6552.967235163841;6566.244881838602;6568.835779105513;4744.319459505368;4783.258594917794;4794.976025119887;4797.544233297831;4810.759462026919;6808.876535371658;6837;6891.2764159763;6924.42987628163;6940.195549157205;4911.533404326583;4977.278294647256;4984.127777638899;5011.123053465629;5028.622853286018;4983.6760610560195;5016.247562865527;5049.242613607915;5073.213651883964;5090.872728181825;5656.773729050792;5670.177824215548;5678.375378708339;5698.287714035746;5706.514946229534;6475.902861457082;6581.506387020992;6600.405963463311;6623.959384775283;6651.966740166268;1644.843739844713;1735.8524525415228;1738.9217485213196;1761.6652835961127;1761.7973932997613;1131.868131868132;1169.0705888818409;1210.7699537087924;1224.9510019599115;1233.481937586216;5724.427557244326;5760.942390576124;5780.248567686174;5782.190493330937;5837.357890632027;6480.4815614750705;6587.670616469158;6610.768623098168;6614.305497922649;6678.632675202911;5581.553475722014;5726.770929162787;5730.885382292331;5749.326563148073;5783.826485205451;3503.1767534629344;3503.964960350415;3511.0689120983866;3522.2427178156818;3554.982225088858;6338.904916426257;6355.3009168991375;6363.140975968185;6431.903521447182;6461.19235095613;6687.799366019027;6761.357671021246;6762.966185169141;6771.93228067713;6848.417884479875;6304.243490781044;6366.26787919386;6423.96788016057;6427.839304017343;6433.806985790434;6517.771877984248;6548.869022619616;6598.406143447113;6620.404163625297;6659.633720145244;6528.412442880163;6580.276169621434;6627.734890604322;6675.666216689049;6702.296258892941;6416.582922110048;6449.871272527383;6467.644279564481;6467.674126804088;6493.2857385688485;4931.901361972812;4960.70235785854;4980.178270585313;5009;5028.472010438997;6516.250631177286;6627.3372662733345;6678.198616166092;6739.528233023641;6751.223609284995;6470.352964703492;6505.8698826024165;6533.509986750918;6544.069499497565;6566.9343306568235;6444.806655800334;6547.70535325902;6548.967255163694;6564.81833270016;6619.338066193534;6153.630782153085;6277.466415354746;6323.146375239284;6490.566037735849;6496.512761542808;6347.587406818542;6389.201349831271;6401.743930242738;6404.93595064062;6556.377144171296;6140.1710769047395;6225.62646241227;6255.218097737783;6259.906101408574;6346.397092276226 00:22:59 INFO - PID 15392 | |5;yui.html;917.7246825952209;933.3046880074345;935.873657056298;939.8402271613825;940.7365937537489;17870.553236169104;18879.339223127194;18975.430737077877;19036.904815475922;19056.71414928777;16916.577085572837;16962;18150.546236344097;21682.674759878573;21749.238776642822;1023.8259495885699;1052.147760314144;1053.436411519837;1054.2567489919627;1059.0838924330437;1050.2438244463974;1050.4537640426972;1051.8106740786654;1051.963181288655;1053.789242151569;1041.5937784264142;1054.7574057966672;1102.3606308341143;1105.6406667832946;1106.0819519798547;1088.6189833558271;1090.2422816142785;1090.3839330778085;1090.5201711247066;1090.6237348114887;790.6442101054491;797.7487091566196;798.2177466083212;798.6525861250317;799.013218674936;18449.354272600394;18715.81284187168;19645.607087858163;19965.101570429364;20017.599648007104;19779.208831646716;20376.388708338774;20793.688094678593;20840.791592084188;20909.163633454642;15463.381464741396;15494.922525387301;15612.375504979787;15677.216139192995;15787.368505259776;3570.803605801706;3603.5675718913635;3613.168971136627;3617.963820361789;3619.5113659656135;122143;122488.38755806253;122574.38712806378;131607;133757.0967049317;16002.279897404645;16085;16137.193140342935;16156.838431615768;16212.270447829877;30476.390472190877;30898.53652195219;31081;31155.53266701001;31257.374852502824;8406.327493800482;8564.357673174536;8621.827563448696;8655.956720216485;8667.393282470166;4250.42619246404;4355.303151495746;4364.388985542027;4374.496932852762;4375.16871794358;5056.974715126401;5182.8963420732125;5256.500632439912;5259.500347466985;5262.236975638511;944.2115833279152;969.3941286695815;978.4814048554135;981.47000619666;987;659.6437923521245;678.91852977643;693.3066933066933;698.5354739098443;704.8660754456637;11167.385793781257;11525.810096081717;11892.524299027942;12293.323867187391;12524.998000159965;632.9936700632935;655.4788942790493;657.5167252069725;661.8279247395616;667.9933200667931;5514.393416724157;5523.922835047128;5528.640638358494;5531.557475401958;5601.971990140023;109952;110371.44814276038;111524.44237778921;112215;113304.43347783208;96392.51803741077;96741.51629241809;97958;98362.5081874586;98809.50595247121;83586;83927.16072839193;84482.57758711166;87252.56373718091;87956.56021719979;10789.514471848628;10818.837717434088;10884.455777211266;10960.945195274291;11241.550337986717;38136.23727525489;38314;38439.423408648334;38804.6119538801;40811;49889.25166122583;50177;50642;50754;50875.23687144622;14892;15133.697326053638;15244.923775381052;15282.847171528143;15344.232788360314;16682.332706691595;16722.414715485385;16779.832201678317;16850.74723879167;16903.239354229336;15470.303836327168;15739.763903541685;15971.8402815975;17883.642327153644;18790.154443050367;19003.90498047501;19155.80844191596;19339.709904351166;19450.61098778045;19851.900740496207;18812.153453094917;18854.434366969013;18894.7165792516;18944.810551894858;19089.713654295476;14236;14454;14507.637309067357;14871.553853384416;15083.547493574772;14296.785548216578;14447.349869255699;14948.639034333768;15098.320575573905;15188.46840360582 00:22:59 INFO - PID 15392 | __end_tp_report 00:22:59 INFO - PID 15392 | __start_cc_report 00:22:59 INFO - PID 15392 | _x_x_mozilla_cycle_collect,386 00:22:59 INFO - PID 15392 | __end_cc_report 00:22:59 INFO - PID 15392 | __startTimestamp1501658579895__endTimestamp 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | ------- Summary: start ------- 00:22:59 INFO - PID 15392 | Number of tests: 6 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | [#0] dojo.html Cycles:165 Average:6115.45 Median:6354.00 stddev:722.99 (11.4%) stddev-sans-first:685.51 00:22:59 INFO - PID 15392 | Values: 3103.5 3150.3 3154.5 3158.7 3192.9 6110.1 6217.6 6246.1 6270.3 6287.9 6023.6 6113.9 6115.7 6147.0 6172.3 5585.0 5608.6 5609.3 5628.0 5633.4 5645.9 5673.7 5686.9 5735.0 5793.2 5642.7 5705.1 5705.5 5714.9 5726.9 5423.5 5488.6 5536.9 5563.3 5638.0 5573.7 5584.9 5617.0 5621.5 5632.0 6040.4 6074.1 6090.1 6133.3 6141.1 6566.4 6584.9 6627.1 6669.0 6670.9 6742.7 6757.2 6774.7 6785.8 6809.1 6184.4 6186.3 6229.3 6270.4 6301.1 6844.9 6867.0 6945.9 6960.5 6964.8 6428.0 6489.0 6521.4 6526.5 6596.7 6622.2 6640.9 6682.8 6716.4 6724.5 6565.4 6600.2 6654.5 6681.5 6700.3 6535.6 6636.3 6673.0 6677.8 6708.1 5455.1 5463.1 5490.8 5494.6 5495.3 4605.6 4630.1 4644.3 4660.0 4673.4 5693.5 5735.6 5765.8 5793.4 5807.2 6611.1 6681.3 6705.1 6726.0 6730.4 5627.8 5736.7 5746.2 5751.4 5776.6 5877.1 5891.6 5897.4 5901.7 5919.7 6425.9 6441.4 6448.2 6454.0 6456.8 6624.1 6647.9 6656.4 6661.3 6668.5 6345.6 6354.0 6452.2 6461.4 6481.1 6516.3 6530.7 6555.5 6565.9 6585.9 6581.9 6614.8 6724.6 6727.8 6738.8 6402.3 6430.8 6516.8 6525.3 6529.6 6365.1 6410.2 6474.5 6482.8 6527.8 6349.7 6409.9 6414.7 6415.1 6421.9 6396.6 6441.2 6509.9 6514.6 6533.6 6225.3 6253.3 6285.4 6325.7 6337.3 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | [#1] ext.html Cycles:180 Average:38248.37 Median:34211.97 stddev:57034.85 (166.7%) stddev-sans-first:57125.57 00:22:59 INFO - PID 15392 | Values: 807.9 876.3 901.4 906.9 1135.0 30257.5 40351.2 40476.6 40521.8 40523.2 40050.2 40416.8 40436.4 40530.6 40618.8 7048.5 7424.7 7561.4 7584.5 7604.6 7480.6 7500.1 7623.3 7625.0 7625.5 7497.2 7638.8 7642.3 7642.6 7668.5 7531.7 7574.7 7588.5 7591.9 7593.9 7401.4 7425.9 7486.1 7491.6 7491.6 37691.2 37887.8 38039.2 38298.4 38315.0 3571.4 3596.5 3609.6 3616.1 3621.0 30389.0 30461.7 30490.5 30577.4 30613.5 4923.1 4937.0 4949.2 4971.3 5046.1 195551.0 196916.0 196937.0 197236.0 197557.0 48403.5 48540.8 48554.0 48758.0 48780.0 50908.7 51466.2 51511.0 51579.7 51599.0 15708.8 15797.0 15806.1 15848.1 15901.9 10727.6 10874.7 10911.6 12721.7 12968.1 14048.8 14095.2 14096.0 14119.2 14205.8 5600.3 5749.1 5800.6 5849.4 5940.8 981.5 1006.5 1014.8 1023.2 1027.9 22448.2 22569.5 22674.9 23266.5 29116.4 1082.4 1084.8 1104.5 1106.1 1108.4 12027.3 12328.0 12418.3 12474.9 12478.8 243372.0 243809.0 243888.0 245450.0 245544.0 49057.3 49187.8 49394.3 49567.0 49812.5 1444.4 1463.0 1499.3 1502.4 1504.6 22456.7 22607.2 22658.4 22830.3 22880.8 36391.8 36638.0 36683.6 36696.4 36713.4 213755.0 215527.0 215797.0 216120.0 216222.0 29726.9 29954.9 29983.3 33010.2 33052.7 41976.2 42052.4 42413.8 42723.8 43335.0 31124.2 31656.2 31707.8 31741.4 31854.8 30741.5 31121.4 31203.5 31389.1 32123.0 34656.8 34673.8 34894.5 34998.5 37300.3 32626.8 33300.0 33511.0 33606.2 33767.2 23752.9 23926.0 24074.4 24817.3 25263.9 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | [#2] jquery.html Cycles:180 Average:36821.93 Median:22797.60 stddev:89600.96 (393.0%) stddev-sans-first:89811.00 00:22:59 INFO - PID 15392 | Values: 584.4 588.5 590.5 596.7 601.8 16113.5 21868.3 22760.4 22849.4 22849.7 18818.0 18931.6 19354.3 19670.4 24532.9 6330.6 6551.2 6558.5 6583.1 6592.0 6327.1 6441.6 6487.4 6489.0 6497.8 5852.2 6442.6 6447.5 6451.5 6465.4 6377.9 6385.1 6393.2 6413.1 6432.8 5969.4 5971.6 5977.0 5979.4 5995.9 27118.6 27732.7 27783.2 28440.4 28491.4 1839.5 1891.0 1891.4 1891.4 1892.1 18718.3 18961.3 18996.1 19023.4 19060.4 2160.2 2215.9 2220.2 2225.0 2239.0 126421.0 132685.0 133445.0 138083.0 142985.6 14510.1 14743.4 14744.9 14960.0 15005.9 23138.0 23187.0 23195.5 23228.6 23273.5 9851.0 9904.2 10015.9 10058.3 10065.9 9218.5 9312.8 9356.3 9369.5 9439.7 9175.8 9176.7 9265.0 9387.9 9390.1 2639.9 2666.8 2687.2 2714.1 2771.8 942.1 969.5 977.5 983.2 993.0 19145.1 23751.3 23752.1 23945.8 24614.5 1027.4 1039.3 1042.5 1054.0 1055.7 10473.6 11082.4 12915.9 13867.6 13949.8 503414.0 530503.0 536575.0 548084.0 548409.0 123385.0 127381.4 127958.4 128064.4 132204.0 1233.0 1256.8 1294.5 1295.0 1317.4 20549.7 20647.7 21223.4 21611.8 21635.6 57757.4 60701.1 62036.7 62591.7 62793.7 77344.2 77345.6 77884.0 78261.6 79040.0 20123.7 20283.5 20483.9 20565.4 20826.2 22834.8 23078.8 23243.2 23379.9 23548.6 17968.6 18042.0 18142.5 18383.9 18427.5 16513.7 16612.9 16778.2 17126.7 17341.0 18563.2 18669.3 18738.0 18801.0 18900.4 19623.1 20071.0 21037.0 21042.0 21046.7 18216.1 18489.6 18490.2 18509.9 18675.3 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | [#3] mootools.html Cycles:180 Average:8467.30 Median:2681.98 stddev:5641.55 (210.4%) stddev-sans-first:5632.05 00:22:59 INFO - PID 15392 | Values: 1353.1 1390.2 1406.2 1416.6 1418.5 13284.6 13341.2 13915.4 13940.4 13942.3 13762.9 14052.8 14054.4 14054.7 14057.9 2675.5 2742.2 2743.2 2744.8 2745.8 2627.3 2724.8 2791.6 2802.6 2816.2 2705.2 2725.3 2749.0 2750.2 2754.9 2688.4 2688.7 2705.9 2733.1 2742.1 2542.9 2550.6 2607.1 2646.6 2652.7 13498.7 13523.2 13567.1 13573.8 13627.2 7361.6 7572.1 7576.7 7616.5 7638.0 4935.3 5133.5 5211.2 5274.2 5386.6 1741.4 1816.1 1818.9 1843.9 1854.1 21694.2 21915.5 21979.6 22621.3 22627.2 6321.2 6500.7 6517.3 6721.5 6821.0 14893.6 14938.6 14941.8 14958.3 14965.1 7317.3 7426.0 7435.7 7437.2 7438.5 6739.2 6792.8 6836.6 6877.0 6896.2 4997.8 5118.3 5166.1 5216.2 5263.1 1388.2 1421.1 1424.3 1425.8 1432.1 886.7 917.6 925.5 928.7 937.3 7036.9 7076.9 7104.6 7130.9 7242.4 725.4 728.6 730.4 730.7 732.2 4961.1 5101.2 5154.8 5238.1 5307.1 17900.6 18289.8 18294.8 18444.8 18546.7 17194.6 18243.3 18784.6 18799.8 18808.8 9599.6 10271.5 10324.5 10327.2 10334.1 8013.7 8215.1 8300.1 8413.7 8807.8 16213.8 16329.6 16365.8 16642.9 16689.8 15764.4 16155.4 16305.7 16469.8 16605.9 10871.2 11095.9 11148.8 11150.6 11158.0 12305.5 12500.2 12516.0 12660.5 12748.7 10005.5 10029.1 10273.0 10318.7 10481.4 10130.1 10154.1 10286.1 10329.6 10427.1 9070.0 9236.0 9291.6 9292.3 9294.8 7015.1 7141.7 7156.7 7231.6 7256.5 7150.5 7266.1 7276.5 7333.6 7370.7 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | [#4] prototype.html Cycles:180 Average:5450.71 Median:6011.32 stddev:1534.24 (25.5%) stddev-sans-first:1492.81 00:22:59 INFO - PID 15392 | Values: 497.4 507.1 515.6 523.6 531.4 6213.7 6223.9 6229.5 6244.5 6282.3 5793.9 5977.5 6010.2 6065.0 6112.4 4894.1 4909.3 4928.7 4950.5 5006.6 4858.4 4892.1 4930.2 4930.7 4966.6 4711.8 4839.0 4841.2 4864.5 4921.4 4817.7 4848.6 4882.8 4884.1 4900.7 4364.7 4375.7 4383.4 4389.4 4415.3 5836.4 5926.4 5981.3 6012.4 6037.8 5574.4 5576.7 5596.5 5613.9 5629.1 6523.2 6524.9 6553.0 6566.2 6568.8 4744.3 4783.3 4795.0 4797.5 4810.8 6808.9 6837.0 6891.3 6924.4 6940.2 4911.5 4977.3 4984.1 5011.1 5028.6 4983.7 5016.2 5049.2 5073.2 5090.9 5656.8 5670.2 5678.4 5698.3 5706.5 6475.9 6581.5 6600.4 6624.0 6652.0 1644.8 1735.9 1738.9 1761.7 1761.8 1131.9 1169.1 1210.8 1225.0 1233.5 5724.4 5760.9 5780.2 5782.2 5837.4 6480.5 6587.7 6610.8 6614.3 6678.6 5581.6 5726.8 5730.9 5749.3 5783.8 3503.2 3504.0 3511.1 3522.2 3555.0 6338.9 6355.3 6363.1 6431.9 6461.2 6687.8 6761.4 6763.0 6771.9 6848.4 6304.2 6366.3 6424.0 6427.8 6433.8 6517.8 6548.9 6598.4 6620.4 6659.6 6528.4 6580.3 6627.7 6675.7 6702.3 6416.6 6449.9 6467.6 6467.7 6493.3 4931.9 4960.7 4980.2 5009.0 5028.5 6516.3 6627.3 6678.2 6739.5 6751.2 6470.4 6505.9 6533.5 6544.1 6566.9 6444.8 6547.7 6549.0 6564.8 6619.3 6153.6 6277.5 6323.1 6490.6 6496.5 6347.6 6389.2 6401.7 6404.9 6556.4 6140.2 6225.6 6255.2 6259.9 6346.4 00:22:59 INFO - PID 15392 | 00:22:59 INFO - PID 15392 | [#5] yui.html Cycles:180 Average:22937.81 Median:19122.76 stddev:31620.74 (165.4%) stddev-sans-first:31666.21 00:22:59 INFO - PID 15392 | Values: 917.7 933.3 935.9 939.8 940.7 17870.6 18879.3 18975.4 19036.9 19056.7 16916.6 16962.0 18150.5 21682.7 21749.2 1023.8 1052.1 1053.4 1054.3 1059.1 1050.2 1050.5 1051.8 1052.0 1053.8 1041.6 1054.8 1102.4 1105.6 1106.1 1088.6 1090.2 1090.4 1090.5 1090.6 790.6 797.7 798.2 798.7 799.0 18449.4 18715.8 19645.6 19965.1 20017.6 19779.2 20376.4 20793.7 20840.8 20909.2 15463.4 15494.9 15612.4 15677.2 15787.4 3570.8 3603.6 3613.2 3618.0 3619.5 122143.0 122488.4 122574.4 131607.0 133757.1 16002.3 16085.0 16137.2 16156.8 16212.3 30476.4 30898.5 31081.0 31155.5 31257.4 8406.3 8564.4 8621.8 8656.0 8667.4 4250.4 4355.3 4364.4 4374.5 4375.2 5057.0 5182.9 5256.5 5259.5 5262.2 944.2 969.4 978.5 981.5 987.0 659.6 678.9 693.3 698.5 704.9 11167.4 11525.8 11892.5 12293.3 12525.0 633.0 655.5 657.5 661.8 668.0 5514.4 5523.9 5528.6 5531.6 5602.0 109952.0 110371.4 111524.4 112215.0 113304.4 96392.5 96741.5 97958.0 98362.5 98809.5 83586.0 83927.2 84482.6 87252.6 87956.6 10789.5 10818.8 10884.5 10960.9 11241.6 38136.2 38314.0 38439.4 38804.6 40811.0 49889.3 50177.0 50642.0 50754.0 50875.2 14892.0 15133.7 15244.9 15282.8 15344.2 16682.3 16722.4 16779.8 16850.7 16903.2 15470.3 15739.8 15971.8 17883.6 18790.2 19003.9 19155.8 19339.7 19450.6 19851.9 18812.2 18854.4 18894.7 18944.8 19089.7 14236.0 14454.0 14507.6 14871.6 15083.5 14296.8 14447.3 14948.6 15098.3 15188.5 00:22:59 INFO - PID 15392 | -------- Summary: end -------- 00:22:59 INFO - PID 15392 | 00:23:00 INFO - TEST-INFO | 15392: exit 0 00:23:00 INFO - TEST-OK | dromaeo_css | took 1112703ms 00:23:00 INFO - TEST-START | kraken 00:23:00 INFO - Initialising browser for kraken test... 00:23:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56048/getInfo.html -profile /tmp/tmpNXKU06/profile 00:23:00 INFO - TEST-INFO | started process 15763 (/builds/slave/test/build/application/firefox/firefox http://localhost:56048/getInfo.html) 00:23:06 INFO - TEST-INFO | 15763: exit 0 00:23:06 INFO - Browser initialized. 00:23:06 INFO - Running cycle 1/1 for kraken test... 00:23:06 INFO - TEST-INFO | started process 15989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXKU06/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:23:07 INFO - PID 15989 | 00:23:07 INFO - PID 15989 | (/builds/slave/test/build/application/firefox/firefox:16043): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:23:07 INFO - PID 15989 | 00:23:17 INFO - PID 15989 | RSS: Main: 174469120 00:23:17 INFO - PID 15989 | 00:23:20 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56048/tests/kraken/driver.html?testName=audio-beat-detection) 00:23:21 INFO - PID 15989 | RSS: Main: 179322880 00:23:21 INFO - PID 15989 | 00:23:24 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56048/tests/kraken/driver.html?testName=audio-dft) 00:23:24 INFO - PID 15989 | RSS: Main: 179425280 00:23:24 INFO - PID 15989 | 00:23:27 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56048/tests/kraken/driver.html?testName=audio-fft) 00:23:28 INFO - PID 15989 | RSS: Main: 174923776 00:23:28 INFO - PID 15989 | 00:23:30 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56048/tests/kraken/driver.html?testName=audio-oscillator) 00:23:31 INFO - PID 15989 | RSS: Main: 175951872 00:23:31 INFO - PID 15989 | 00:23:33 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56048/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:23:34 INFO - PID 15989 | RSS: Main: 175730688 00:23:34 INFO - PID 15989 | 00:23:37 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56048/tests/kraken/driver.html?testName=imaging-darkroom) 00:23:38 INFO - PID 15989 | RSS: Main: 178262016 00:23:38 INFO - PID 15989 | 00:23:41 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56048/tests/kraken/driver.html?testName=imaging-desaturate) 00:23:42 INFO - PID 15989 | RSS: Main: 177106944 00:23:42 INFO - PID 15989 | 00:23:45 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56048/tests/kraken/driver.html?testName=json-parse-financial) 00:23:45 INFO - PID 15989 | RSS: Main: 178434048 00:23:45 INFO - PID 15989 | 00:23:47 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56048/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:23:48 INFO - PID 15989 | RSS: Main: 178012160 00:23:48 INFO - PID 15989 | 00:23:49 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:23:50 INFO - PID 15989 | RSS: Main: 175362048 00:23:50 INFO - PID 15989 | 00:23:52 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:23:53 INFO - PID 15989 | RSS: Main: 175509504 00:23:53 INFO - PID 15989 | 00:23:56 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:23:57 INFO - PID 15989 | RSS: Main: 176009216 00:23:57 INFO - PID 15989 | 00:24:00 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:24:00 INFO - PID 15989 | RSS: Main: 176070656 00:24:00 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | Cycle 1(1): loaded http://localhost:56048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56048/tests/kraken/driver.html?testName=ai-astar) 00:24:02 INFO - PID 15989 | RSS: Main: 177979392 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | __start_tp_report 00:24:02 INFO - PID 15989 | _x_x_mozilla_page_load 00:24:02 INFO - PID 15989 | _x_x_mozilla_page_load_details 00:24:02 INFO - PID 15989 | |i|pagename|runs| 00:24:02 INFO - PID 15989 | |0;ai-astar;98;109;110;108;110;112;110;103;108;107 00:24:02 INFO - PID 15989 | |1;audio-beat-detection;148;122;146;194;124;141;147;126;171;123 00:24:02 INFO - PID 15989 | |2;audio-dft;163;172;164;162;165;166;182;170;166;163 00:24:02 INFO - PID 15989 | |3;audio-fft;77;75;81;173;78;73;76;79;144;74 00:24:02 INFO - PID 15989 | |4;audio-oscillator;78;79;126;82;79;80;123;81;85;125 00:24:02 INFO - PID 15989 | |5;imaging-gaussian-blur;116;115;114;114;115;114;115;113;114;114 00:24:02 INFO - PID 15989 | |6;imaging-darkroom;152;159;150;152;155;154;152;154;151;151 00:24:02 INFO - PID 15989 | |7;imaging-desaturate;93;97;97;98;94;99;93;100;94;95 00:24:02 INFO - PID 15989 | |8;json-parse-financial;60;57;56;55;60;56;55;55;56;61 00:24:02 INFO - PID 15989 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;54;54;53 00:24:02 INFO - PID 15989 | |10;stanford-crypto-aes;80;80;78;78;80;78;77;77;79;81 00:24:02 INFO - PID 15989 | |11;stanford-crypto-ccm;132;144;136;133;145;134;138;152;130;171 00:24:02 INFO - PID 15989 | |12;stanford-crypto-pbkdf2;176;182;171;175;174;183;173;176;190;178 00:24:02 INFO - PID 15989 | |13;stanford-crypto-sha256-iterative;67;68;72;66;65;65;69;73;69;69 00:24:02 INFO - PID 15989 | __end_tp_report 00:24:02 INFO - PID 15989 | __start_cc_report 00:24:02 INFO - PID 15989 | _x_x_mozilla_cycle_collect,980 00:24:02 INFO - PID 15989 | __end_cc_report 00:24:02 INFO - PID 15989 | __startTimestamp1501658642886__endTimestamp 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | ------- Summary: start ------- 00:24:02 INFO - PID 15989 | Number of tests: 14 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#0] ai-astar Cycles:10 Average:107.50 Median:110.00 stddev:4.12 (3.7%) stddev-sans-first:2.55 00:24:02 INFO - PID 15989 | Values: 98.0 109.0 110.0 108.0 110.0 112.0 110.0 103.0 108.0 107.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:146.50 stddev:23.37 (16.0%) stddev-sans-first:24.75 00:24:02 INFO - PID 15989 | Values: 148.0 122.0 146.0 194.0 124.0 141.0 147.0 126.0 171.0 123.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#2] audio-dft Cycles:10 Average:167.30 Median:166.00 stddev:6.06 (3.6%) stddev-sans-first:6.22 00:24:02 INFO - PID 15989 | Values: 163.0 172.0 164.0 162.0 165.0 166.0 182.0 170.0 166.0 163.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:35.27 (46.1%) stddev-sans-first:36.93 00:24:02 INFO - PID 15989 | Values: 77.0 75.0 81.0 173.0 78.0 73.0 76.0 79.0 144.0 74.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:79.50 stddev:21.40 (26.9%) stddev-sans-first:21.92 00:24:02 INFO - PID 15989 | Values: 78.0 79.0 126.0 82.0 79.0 80.0 123.0 81.0 85.0 125.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.67 00:24:02 INFO - PID 15989 | Values: 116.0 115.0 114.0 114.0 115.0 114.0 115.0 113.0 114.0 114.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#6] imaging-darkroom Cycles:10 Average:153.00 Median:153.00 stddev:2.62 (1.7%) stddev-sans-first:2.76 00:24:02 INFO - PID 15989 | Values: 152.0 159.0 150.0 152.0 155.0 154.0 152.0 154.0 151.0 151.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:2.54 (2.6%) stddev-sans-first:2.45 00:24:02 INFO - PID 15989 | Values: 93.0 97.0 97.0 98.0 94.0 99.0 93.0 100.0 94.0 95.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:2.33 (4.1%) stddev-sans-first:2.22 00:24:02 INFO - PID 15989 | Values: 60.0 57.0 56.0 55.0 60.0 56.0 55.0 55.0 56.0 61.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 00:24:02 INFO - PID 15989 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.50 stddev:1.40 (1.8%) stddev-sans-first:1.41 00:24:02 INFO - PID 15989 | Values: 80.0 80.0 78.0 78.0 80.0 78.0 77.0 77.0 79.0 81.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:141.00 stddev:12.44 (8.8%) stddev-sans-first:12.71 00:24:02 INFO - PID 15989 | Values: 132.0 144.0 136.0 133.0 145.0 134.0 138.0 152.0 130.0 171.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:177.00 stddev:5.69 (3.2%) stddev-sans-first:6.00 00:24:02 INFO - PID 15989 | Values: 176.0 182.0 171.0 175.0 174.0 183.0 173.0 176.0 190.0 178.0 00:24:02 INFO - PID 15989 | 00:24:02 INFO - PID 15989 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:2.71 (3.9%) stddev-sans-first:2.83 00:24:02 INFO - PID 15989 | Values: 67.0 68.0 72.0 66.0 65.0 65.0 69.0 73.0 69.0 69.0 00:24:02 INFO - PID 15989 | -------- Summary: end -------- 00:24:02 INFO - PID 15989 | 00:24:03 INFO - PID 15989 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:24:03 INFO - TEST-INFO | 15989: exit 0 00:24:03 INFO - TEST-OK | kraken | took 63104ms 00:24:03 INFO - SUITE-END | took 1175s 00:24:04 INFO - Completed test suite (00:19:36) 00:24:04 INFO - javascript benchmark 00:24:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8409.842459540714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.5034394496897, 3150.2911844834916, 3154.495280755079, 3158.652548219694, 3192.888248911288, 6110.052941794023, 6217.62694238346, 6246.09431632413, 6270.27891792444, 6287.874242515159, 6023.608465449743, 6113.938860611393, 6115.663638499881, 6147.0472076828055, 6172.321044685081, 5585.0, 5608.5793565482545, 5609.3268807743125, 5627.971860140704, 5633.408492108331, 5645.943540564583, 5673.659580425167, 5686.914696279559, 5734.97132514339, 5793.246877905866, 5642.689652069134, 5705.087186050233, 5705.5435565154685, 5714.914276285859, 5726.942730572682, 5423.538999185074, 5488.588355873326, 5536.916946245809, 5563.304586926634, 5638.0, 5573.721313934328, 5584.86037849053, 5616.971915140398, 5621.494065534122, 5632.0, 6040.395960403968, 6074.088886666991, 6090.147379366892, 6133.325334213233, 6141.140240366352, 6566.409023187936, 6584.868302633969, 6627.105340778981, 6668.966655166693, 6670.866582668319, 6742.696578653972, 6757.155355580552, 6774.69513871872, 6785.762498312584, 6809.080774095532, 6184.350643182446, 6186.319504854418, 6229.345918678564, 6270.372962703739, 6301.149344838388, 6844.863102738017, 6867.038614593961, 6945.89581156283, 6960.512764106464, 6964.825879353057, 6428.0, 6489.0, 6521.413072823469, 6526.543141980016, 6596.736130554724, 6622.205335359788, 6640.867182656417, 6682.83292917681, 6716.361945615159, 6724.529282950244, 6565.376289252514, 6600.207975043026, 6654.500912431587, 6681.532292739559, 6700.329967003261, 6535.607863528204, 6636.30318816527, 6672.966635166793, 6677.833054173588, 6708.060871477997, 5455.072637651609, 5463.125899856083, 5490.780368785284, 5494.642848214853, 5495.34055913285, 4605.631549476034, 4630.073985202973, 4644.2801365788355, 4660.044690838437, 4673.439187297546, 5693.516051135617, 5735.598508104393, 5765.827025189251, 5793.420657934257, 5807.157962095473, 6611.074449577063, 6681.298463661343, 6705.094812200388, 6726.0, 6730.427913627299, 5627.774889004476, 5736.68448235351, 5746.195532625436, 5751.424857514216, 5776.56675749312, 5877.147813567009, 5891.558133140032, 5897.439743224387, 5901.704914754245, 5919.67441790697, 6425.935740642627, 6441.355864413521, 6448.193975753031, 6454.0, 6456.806295811133, 6624.138861947916, 6647.933520664731, 6656.400923916871, 6661.300563440963, 6668.499862510234, 6345.587536810092, 6354.0, 6452.225732911893, 6461.38616831419, 6481.060246264359, 6516.348365163635, 6530.738770449128, 6555.541112122296, 6565.934340656532, 6585.913324301437, 6581.868362632817, 6614.768483103068, 6724.630145342053, 6727.798166055026, 6738.764143254963, 6402.327755585783, 6430.807075787734, 6516.826971145239, 6525.3148419417175, 6529.575577587631, 6365.108884756045, 6410.1987251593555, 6474.4820414365795, 6482.773102941374, 6527.771527996498, 6349.746010159727, 6409.9359006411205, 6414.679266036586, 6415.133956915944, 6421.871562568629, 6396.584222025554, 6441.1626488556185, 6509.8698026040165, 6514.57655252407, 6533.640649764308, 6225.28409232944, 6253.343398943228, 6285.43431091204, 6325.683715814283, 6337.334579869047], "value": 6061.358801628777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.9353651707864, 876.2945828607972, 901.4140808474491, 906.9093090690927, 1134.9716257093576, 30257.546136807938, 40351.19297614046, 40476.59523404769, 40521.79739101304, 40523.189536209255, 40050.19899602013, 40416.79791601045, 40436.393454098135, 40530.59469405305, 40618.79690601543, 7048.471364647647, 7424.740134095294, 7561.357284630813, 7584.4690871639, 7604.619769011555, 7480.62596870157, 7500.137484189307, 7623.313901748841, 7625.0, 7625.466217364787, 7497.212792656775, 7638.809029774272, 7642.312191902728, 7642.617869106551, 7668.501547399401, 7531.698732050711, 7574.734884279052, 7588.544687318723, 7591.8861217081785, 7593.886091708629, 7401.444891633149, 7425.925740742631, 7486.101667799844, 7491.587962662052, 7491.625418729096, 37691.24617507635, 37887.81056094702, 38039.23921521554, 38298.42552361717, 38315.0, 3571.357155711971, 3596.496490491333, 3609.5668519777796, 3616.132128289218, 3621.0, 30389.0, 30461.695383046328, 30490.54264186039, 30577.38845223083, 30613.540796888065, 4923.064617722621, 4936.950630493685, 4949.208126699711, 4971.328870602495, 5046.09170349337, 195551.0, 196915.99999999857, 196937.0, 197236.0, 197557.0, 48403.515964840604, 48540.844845084954, 48554.0, 48758.0, 48780.0, 50908.745456273224, 51466.228006579186, 51511.0, 51579.74210128925, 51599.0, 15708.764368534481, 15797.0, 15806.130662813655, 15848.128352940468, 15901.920490397473, 10727.570897164025, 10874.67375978722, 10911.618093366853, 12721.745565088646, 12968.09223354375, 14048.789268160986, 14095.154290742588, 14096.02655628213, 14119.152850828983, 14205.78691319631, 5600.267773731191, 5749.051406517961, 5800.564957628195, 5849.444302791228, 5940.792072277536, 981.5435822342645, 1006.5319626373771, 1014.8477728340808, 1023.2223510132204, 1027.9331843430152, 22448.214312498985, 22569.548609027726, 22674.886625566767, 23266.53466930652, 29116.41767164645, 1082.426314053553, 1084.7830433913248, 1104.5250542266901, 1106.0819519798547, 1108.4070022537903, 12027.338496382783, 12328.0, 12418.316992565315, 12474.875251247371, 12478.81281780774, 243372.0, 243809.0, 243888.0, 245450.0, 245544.0, 49057.2641410372, 49187.75406122946, 49394.259086113736, 49567.0, 49812.501874980786, 1444.3789170656507, 1462.978055329171, 1499.2803454341977, 1502.361496364041, 1504.5636765338147, 22456.66315005309, 22607.208747693752, 22658.43353916165, 22830.31509054731, 22880.771192287863, 36391.818040909624, 36638.0, 36683.63316366909, 36696.449553257255, 36713.44929826001, 213755.0, 215527.0, 215797.0, 216120.0, 216222.0, 29726.851365743034, 29954.85022574873, 29983.250418738833, 33010.17474563059, 33052.66947330496, 41976.1604767909, 42052.36921446119, 42413.78793106015, 42723.7863810679, 43335.0, 31124.22189445282, 31656.208594785316, 31707.841460792548, 31741.365172695954, 31854.840725796224, 30741.538876916416, 31121.377572448877, 31203.531947020358, 31389.116653000892, 32123.0, 34656.78701245444, 34673.826630866686, 34894.476582851785, 34998.47502287417, 37300.253994920495, 32626.83686581552, 33300.0, 33510.99467015993, 33606.159846003065, 33767.15582110467, 23752.88123559371, 23926.0, 24074.39814004664, 24817.25548233556, 25263.87368063148], "value": 17035.329558862617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4068270705235, 588.5379976718276, 590.530528230057, 596.6777939912447, 601.8044135655913, 16113.516594502154, 21868.343949681515, 22760.43098922528, 22849.42876428086, 22849.657255141166, 18818.0, 18931.62136757264, 19354.322598709048, 19670.409887703358, 24532.877335613342, 6330.588511746733, 6551.246606640249, 6558.508111891603, 6583.111279977214, 6592.0, 6327.1458353122425, 6441.645709485976, 6487.448566871822, 6489.0, 6497.837554061139, 5852.180694702745, 6442.6134431934, 6447.451966582846, 6451.516136289773, 6465.3534646535445, 6377.936220637804, 6385.138006369174, 6393.200849893763, 6413.102165696783, 6432.839179020515, 5969.432903874125, 5971.552133589955, 5977.0, 5979.372165922559, 5995.880082398327, 27118.5932211017, 27732.722672773416, 27783.166505004883, 28440.431191376058, 28491.430171396456, 1839.5401149712573, 1890.962180756391, 1891.4231159496348, 1891.4231159496348, 1892.0634286028503, 18718.251269949185, 18961.336353227707, 18996.145173467226, 19023.429297121107, 19060.428187154408, 2160.2223199648115, 2215.9446013849783, 2220.2340192633515, 2224.9666255006186, 2238.9888050559807, 126421.0, 132685.0, 133445.0, 138083.0, 142985.57014429825, 14510.069168448195, 14743.410263589336, 14744.926275368554, 14960.027598206081, 15005.920234211346, 23138.0, 23187.0, 23195.53608927812, 23228.606283623038, 23273.534529309658, 9850.950745246371, 9904.15814655748, 10015.899841001643, 10058.34620749649, 10065.899341006643, 9218.468918648758, 9312.767180820534, 9356.27103120092, 9369.484678342757, 9439.716808495756, 9175.77060573491, 9176.6788162414, 9265.0, 9387.90612093884, 9390.060993900555, 2639.947201055968, 2666.8266562673366, 2687.193841847438, 2714.0907795888597, 2771.8336899786077, 942.1426501883253, 969.520087556664, 977.452626529146, 983.179045497018, 993.0218734546465, 19145.13846876894, 23751.287461376185, 23752.06578659165, 23945.760542394702, 24614.538821001363, 1027.4041056187393, 1039.262123892045, 1042.5040067503157, 1053.9683809485575, 1055.7430327439934, 10473.583793664942, 11082.445877706083, 12915.935420323027, 13867.583972480841, 13949.790753138712, 503414.0, 530503.0, 536575.0, 548084.0, 548409.0, 123385.0, 127381.36309318579, 127958.36020819837, 128064.35967820101, 132204.0, 1232.975340493185, 1256.773780719461, 1294.527497463419, 1295.0416691648113, 1317.3544962968076, 20549.691754623993, 20647.690284646043, 21223.363299101053, 21611.783882160977, 21635.567288654453, 57757.42242577521, 60701.0894836569, 62036.68981655063, 62591.6870415645, 62793.68603156955, 77344.22655773371, 77345.61327193328, 77884.0, 78261.60869195618, 79040.0, 20123.698144528138, 20283.492912677302, 20483.87338696386, 20565.354771617935, 20826.1669533217, 22834.771652283263, 23078.769212308332, 23243.186488472824, 23379.88310058439, 23548.6467702988, 17968.550786230448, 18042.0, 18142.5464363392, 18383.90808045951, 18427.539311516783, 16513.66972660564, 16612.916935415247, 16778.1610919456, 17126.74309885328, 17341.046242456785, 18563.164657590172, 18669.346572869883, 18738.0, 18800.965946872508, 18900.432987010412, 19623.11695973713, 20071.0, 21037.0, 21042.0, 21046.68429973521, 18216.089195539906, 18489.630207396047, 18490.16794244289, 18509.907450462662, 18675.252989880253], "value": 12285.443292403375, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.0934274036397, 1390.2423179367245, 1406.226575383539, 1416.5821082780578, 1418.4609848257667, 13284.601461956157, 13341.199528028314, 13915.44338226471, 13940.44238230471, 13942.302884855742, 13762.862371376283, 14052.789208161887, 14054.367553460093, 14054.718905621881, 14057.929710351435, 2675.545157323255, 2742.245882382351, 2743.1770468859363, 2744.821586596875, 2745.835249885013, 2627.2512333984723, 2724.7547720705134, 2791.6091747155415, 2802.565602331642, 2816.1833068410137, 2705.161399966007, 2725.3459169799203, 2748.9862550687217, 2750.1612008337447, 2754.944901101987, 2688.4085501189707, 2688.6504754382, 2705.8917643294244, 2733.098077634386, 2742.081402730068, 2542.9109981150573, 2550.5919052951626, 2607.087519368206, 2646.629471873939, 2652.655154829879, 13498.730025399534, 13523.188608683511, 13567.05030647855, 13573.796393054112, 13627.182369057888, 7361.595112268823, 7572.053493313336, 7576.696932122763, 7616.504927179715, 7638.0, 4935.3090567320605, 5133.512316329943, 5211.2443695663915, 5274.182501712241, 5386.622936394454, 1741.364401993276, 1816.0828781465407, 1818.945431637053, 1843.944681659539, 1854.1470923375264, 21694.240701575527, 21915.452113697283, 21979.560408791735, 22621.321360359216, 22627.20804771825, 6321.241451025814, 6500.667363190534, 6517.315681853432, 6721.462283017347, 6821.0, 14893.627659308604, 14938.626534336729, 14941.775873361908, 14958.252087395587, 14965.102093874402, 7317.341439270384, 7425.9628701856145, 7435.665395057127, 7437.181909989897, 7438.516496427715, 6739.191297044386, 6792.762253321209, 6836.555623884432, 6876.965615171992, 6896.241413444517, 4997.750112494361, 5118.334616499831, 5166.095933211673, 5216.165413533817, 5263.105272103751, 1388.2364699415282, 1421.1118051217989, 1424.3163281624877, 1425.836028856674, 1432.0548438031058, 886.7073865624328, 917.6467060181744, 925.4817302310728, 928.726025822384, 937.2876613773581, 7036.92963070373, 7076.929230707627, 7104.609246491389, 7130.893036604455, 7242.3843973262865, 725.4232884856551, 728.613834667627, 730.3901242462604, 730.7077169132283, 732.2348146187247, 4961.107000739901, 5101.158308879068, 5154.819581314636, 5238.083335416287, 5307.097793375136, 17900.641987160183, 18289.817101829078, 18294.817051829577, 18444.81555184458, 18546.721799173025, 17194.570135746457, 18243.27026918935, 18784.62430751377, 18799.812001879807, 18808.81191188098, 9599.616015359446, 10271.537780799881, 10324.483775811179, 10327.173826093895, 10334.069933706003, 8013.6794528218215, 8215.096339402542, 8300.12848650883, 8413.747587572383, 8807.823843523222, 16213.756793648341, 16329.591760206089, 16365.754513682066, 16642.916785415997, 16689.833101668828, 15764.369425222863, 16155.353785848434, 16305.67388652244, 16469.83530164683, 16605.91697041507, 10871.239013268996, 11095.944520277348, 11148.777024459303, 11150.553977840795, 11158.0, 12305.507779688713, 12500.187487813264, 12516.0, 12660.493580257054, 12748.681282968, 10005.499725013575, 10029.097381235724, 10273.0, 10318.742031449274, 10481.42352170638, 10130.08829205375, 10154.136898363426, 10286.074253317238, 10329.638462653771, 10427.061564459234, 9070.0, 9236.030216827136, 9291.62833486653, 9292.303077269096, 9294.814103717752, 7015.123109611299, 7141.678624461808, 7156.749513766993, 7231.63841807918, 7256.528325658815, 7150.463715221484, 7266.091738532684, 7276.4542659299705, 7333.633318333956, 7370.705171793283], "value": 6229.623502166257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.43060643669213, 507.13027158423296, 515.6081378152604, 523.5628250410907, 531.4287141323078, 6213.720382582784, 6223.875522489548, 6229.532785041129, 6244.500439964803, 6282.277538083122, 5793.913091303634, 5977.462028417442, 6010.248718910137, 6064.9696751516185, 6112.449879510854, 4894.143524883149, 4909.263610458442, 4928.728919909404, 4950.504949505057, 5006.624503162259, 4858.392700912386, 4892.119418504668, 4930.161872481687, 4930.704157750529, 4966.5778408835295, 4711.764411779414, 4839.032193561302, 4841.225403935371, 4864.513548645143, 4921.360223170983, 4817.710937343771, 4848.587870031051, 4882.829100981484, 4884.096442158212, 4900.6569540132205, 4364.672649551297, 4375.7155784873885, 4383.364412160251, 4389.363542286383, 4415.2935530315, 5836.445537673914, 5926.4073592640825, 5981.342052374235, 6012.398760123996, 6037.849053773691, 5574.414686457904, 5576.749046292886, 5596.496315331599, 5613.915791263134, 5629.057974998619, 6523.151990241238, 6524.869502609969, 6552.967235163841, 6566.244881838602, 6568.835779105513, 4744.319459505368, 4783.258594917794, 4794.976025119887, 4797.544233297831, 4810.759462026919, 6808.876535371658, 6837.0, 6891.2764159763, 6924.42987628163, 6940.195549157205, 4911.533404326583, 4977.278294647256, 4984.127777638899, 5011.123053465629, 5028.622853286018, 4983.6760610560195, 5016.247562865527, 5049.242613607915, 5073.213651883964, 5090.872728181825, 5656.773729050792, 5670.177824215548, 5678.375378708339, 5698.287714035746, 5706.514946229534, 6475.902861457082, 6581.506387020992, 6600.405963463311, 6623.959384775283, 6651.966740166268, 1644.843739844713, 1735.8524525415228, 1738.9217485213196, 1761.6652835961127, 1761.7973932997613, 1131.868131868132, 1169.0705888818409, 1210.7699537087924, 1224.9510019599115, 1233.481937586216, 5724.427557244326, 5760.942390576124, 5780.248567686174, 5782.190493330937, 5837.357890632027, 6480.4815614750705, 6587.670616469158, 6610.768623098168, 6614.305497922649, 6678.632675202911, 5581.553475722014, 5726.770929162787, 5730.885382292331, 5749.326563148073, 5783.826485205451, 3503.1767534629344, 3503.964960350415, 3511.0689120983866, 3522.2427178156818, 3554.982225088858, 6338.904916426257, 6355.3009168991375, 6363.140975968185, 6431.903521447182, 6461.19235095613, 6687.799366019027, 6761.357671021246, 6762.966185169141, 6771.93228067713, 6848.417884479875, 6304.243490781044, 6366.26787919386, 6423.96788016057, 6427.839304017343, 6433.806985790434, 6517.771877984248, 6548.869022619616, 6598.406143447113, 6620.404163625297, 6659.633720145244, 6528.412442880163, 6580.276169621434, 6627.734890604322, 6675.666216689049, 6702.296258892941, 6416.582922110048, 6449.871272527383, 6467.644279564481, 6467.674126804088, 6493.2857385688485, 4931.901361972812, 4960.70235785854, 4980.178270585313, 5009.0, 5028.472010438997, 6516.250631177286, 6627.3372662733345, 6678.198616166092, 6739.528233023641, 6751.223609284995, 6470.352964703492, 6505.8698826024165, 6533.509986750918, 6544.069499497565, 6566.9343306568235, 6444.806655800334, 6547.70535325902, 6548.967255163694, 6564.81833270016, 6619.338066193534, 6153.630782153085, 6277.466415354746, 6323.146375239284, 6490.566037735849, 6496.512761542808, 6347.587406818542, 6389.201349831271, 6401.743930242738, 6404.93595064062, 6556.377144171296, 6140.1710769047395, 6225.62646241227, 6255.218097737783, 6259.906101408574, 6346.397092276226], "value": 4999.721579277471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.7246825952209, 933.3046880074345, 935.873657056298, 939.8402271613825, 940.7365937537489, 17870.553236169104, 18879.339223127194, 18975.430737077877, 19036.904815475922, 19056.71414928777, 16916.577085572837, 16962.0, 18150.546236344097, 21682.674759878573, 21749.238776642822, 1023.8259495885699, 1052.147760314144, 1053.436411519837, 1054.2567489919627, 1059.0838924330437, 1050.2438244463974, 1050.4537640426972, 1051.8106740786654, 1051.963181288655, 1053.789242151569, 1041.5937784264142, 1054.7574057966672, 1102.3606308341143, 1105.6406667832946, 1106.0819519798547, 1088.6189833558271, 1090.2422816142785, 1090.3839330778085, 1090.5201711247066, 1090.6237348114887, 790.6442101054491, 797.7487091566196, 798.2177466083212, 798.6525861250317, 799.013218674936, 18449.354272600394, 18715.81284187168, 19645.607087858163, 19965.101570429364, 20017.599648007104, 19779.208831646716, 20376.388708338774, 20793.688094678593, 20840.791592084188, 20909.163633454642, 15463.381464741396, 15494.922525387301, 15612.375504979787, 15677.216139192995, 15787.368505259776, 3570.803605801706, 3603.5675718913635, 3613.168971136627, 3617.963820361789, 3619.5113659656135, 122143.0, 122488.38755806253, 122574.38712806378, 131607.0, 133757.0967049317, 16002.279897404645, 16085.0, 16137.193140342935, 16156.838431615768, 16212.270447829877, 30476.390472190877, 30898.53652195219, 31081.0, 31155.53266701001, 31257.374852502824, 8406.327493800482, 8564.357673174536, 8621.827563448696, 8655.956720216485, 8667.393282470166, 4250.42619246404, 4355.303151495746, 4364.388985542027, 4374.496932852762, 4375.16871794358, 5056.974715126401, 5182.8963420732125, 5256.500632439912, 5259.500347466985, 5262.236975638511, 944.2115833279152, 969.3941286695815, 978.4814048554135, 981.47000619666, 987.0, 659.6437923521245, 678.91852977643, 693.3066933066933, 698.5354739098443, 704.8660754456637, 11167.385793781257, 11525.810096081717, 11892.524299027942, 12293.323867187391, 12524.998000159965, 632.9936700632935, 655.4788942790493, 657.5167252069725, 661.8279247395616, 667.9933200667931, 5514.393416724157, 5523.922835047128, 5528.640638358494, 5531.557475401958, 5601.971990140023, 109952.0, 110371.44814276038, 111524.44237778921, 112215.0, 113304.43347783208, 96392.51803741077, 96741.51629241809, 97958.0, 98362.5081874586, 98809.50595247121, 83586.0, 83927.16072839193, 84482.57758711166, 87252.56373718091, 87956.56021719979, 10789.514471848628, 10818.837717434088, 10884.455777211266, 10960.945195274291, 11241.550337986717, 38136.23727525489, 38314.0, 38439.423408648334, 38804.6119538801, 40811.0, 49889.25166122583, 50177.0, 50642.0, 50754.0, 50875.23687144622, 14892.0, 15133.697326053638, 15244.923775381052, 15282.847171528143, 15344.232788360314, 16682.332706691595, 16722.414715485385, 16779.832201678317, 16850.74723879167, 16903.239354229336, 15470.303836327168, 15739.763903541685, 15971.8402815975, 17883.642327153644, 18790.154443050367, 19003.90498047501, 19155.80844191596, 19339.709904351166, 19450.61098778045, 19851.900740496207, 18812.153453094917, 18854.434366969013, 18894.7165792516, 18944.810551894858, 19089.713654295476, 14236.0, 14454.0, 14507.637309067357, 14871.553853384416, 15083.547493574772, 14296.785548216578, 14447.349869255699, 14948.639034333768, 15098.320575573905, 15188.46840360582], "value": 8953.244658406482, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 109.0, 110.0, 108.0, 110.0, 112.0, 110.0, 103.0, 108.0, 107.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 146.0, 194.0, 124.0, 141.0, 147.0, 126.0, 171.0, 123.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 172.0, 164.0, 162.0, 165.0, 166.0, 182.0, 170.0, 166.0, 163.0], "value": 167.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 81.0, 173.0, 78.0, 73.0, 76.0, 79.0, 144.0, 74.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 126.0, 82.0, 79.0, 80.0, 123.0, 81.0, 85.0, 125.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 113.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 150.0, 152.0, 155.0, 154.0, 152.0, 154.0, 151.0, 151.0], "value": 153.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 97.0, 98.0, 94.0, 99.0, 93.0, 100.0, 94.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 56.0, 55.0, 60.0, 56.0, 55.0, 55.0, 56.0, 61.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 78.0, 80.0, 78.0, 77.0, 77.0, 79.0, 81.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 144.0, 136.0, 133.0, 145.0, 134.0, 138.0, 152.0, 130.0, 171.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 182.0, 171.0, 175.0, 174.0, 183.0, 173.0, 176.0, 190.0, 178.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 72.0, 66.0, 65.0, 65.0, 69.0, 73.0, 69.0, 69.0], "value": 68.3, "unit": "score"}]}]} 00:24:04 INFO - Return code: 0 00:24:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:24:04 INFO - # TBPL SUCCESS # 00:24:04 INFO - Running post-action listener: _package_coverage_data 00:24:04 INFO - Running post-action listener: _resource_record_post_action 00:24:04 INFO - [mozharness: 2017-08-02 07:24:04.195034Z] Finished run-tests step (success) 00:24:04 INFO - Running post-run listener: _resource_record_post_run 00:24:04 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 438362112; Read time: 40; Write time: 472144 00:24:04 INFO - TinderboxPrint: CPU usage
13.2% 00:24:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 40 00:24:04 INFO - TinderboxPrint: I/O write bytes / time
438,362,112 / 472,144 00:24:04 INFO - TinderboxPrint: CPU idle
8,269.9 (86.8%) 00:24:04 INFO - TinderboxPrint: CPU user
1,205.6 (12.7%) 00:24:04 INFO - TinderboxPrint: Swap in / out
0 / 0 00:24:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 113422336; Read time: 0; Write time: 160828 00:24:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:24:04 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 324939776; Read time: 0; Write time: 311316 00:24:04 INFO - Running post-run listener: _upload_blobber_files 00:24:04 INFO - Blob upload gear active. 00:24:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:24:04 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 00:24:04 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:24:04 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:24:05 INFO - (blobuploader) - INFO - Open directory for files ... 00:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:24:06 INFO - (blobuploader) - INFO - Done attempting. 00:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:24:06 INFO - (blobuploader) - INFO - Done attempting. 00:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:24:07 INFO - (blobuploader) - INFO - Done attempting. 00:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:24:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:24:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:24:15 INFO - (blobuploader) - INFO - Done attempting. 00:24:15 INFO - (blobuploader) - INFO - Iteration through files over. 00:24:15 INFO - Return code: 0 00:24:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:24:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:24:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bb95b268cba08076866e22fe62076bfe175ebfb7c87237113f1740a91c85517b21b9ba3704fa4f1e17959c665e4a404dde0665fe8796c482dcac0c9ccb55e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65523abdc6d349136ce5861b06494822de9175aa6615d70163ee0937171907fc3bd6ac3a33da840d4c3d2ecff0e8b7a06be10e15238482cab66cca3db716e1a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/491fab5982ae069d87f4b2c6aed9c03e995d9cdd0ad55f6318f39e04ced133e3f356296bf8a5fa2fed976237ec9604fa90488493c343d21b7e9b2241b02ad9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2007014ac19df7969713fa487eecb1fedbab6d2914974a033156ec217285a5013b37d4f5fac9fa688c7a85755a9a4aa5d91821f7c500ce58b8be81b5e8ba79c0"} 00:24:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:24:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:24:15 INFO - Contents: 00:24:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bb95b268cba08076866e22fe62076bfe175ebfb7c87237113f1740a91c85517b21b9ba3704fa4f1e17959c665e4a404dde0665fe8796c482dcac0c9ccb55e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65523abdc6d349136ce5861b06494822de9175aa6615d70163ee0937171907fc3bd6ac3a33da840d4c3d2ecff0e8b7a06be10e15238482cab66cca3db716e1a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/491fab5982ae069d87f4b2c6aed9c03e995d9cdd0ad55f6318f39e04ced133e3f356296bf8a5fa2fed976237ec9604fa90488493c343d21b7e9b2241b02ad9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2007014ac19df7969713fa487eecb1fedbab6d2914974a033156ec217285a5013b37d4f5fac9fa688c7a85755a9a4aa5d91821f7c500ce58b8be81b5e8ba79c0"} 00:24:15 INFO - Running post-run listener: copy_logs_to_upload_dir 00:24:15 INFO - Copying logs to upload dir... 00:24:15 INFO - mkdir: /builds/slave/test/build/upload/logs 00:24:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.835172 ========= master_lag: -0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-02 00:24:15.143793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 00:24:15.148201) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bb95b268cba08076866e22fe62076bfe175ebfb7c87237113f1740a91c85517b21b9ba3704fa4f1e17959c665e4a404dde0665fe8796c482dcac0c9ccb55e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65523abdc6d349136ce5861b06494822de9175aa6615d70163ee0937171907fc3bd6ac3a33da840d4c3d2ecff0e8b7a06be10e15238482cab66cca3db716e1a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/491fab5982ae069d87f4b2c6aed9c03e995d9cdd0ad55f6318f39e04ced133e3f356296bf8a5fa2fed976237ec9604fa90488493c343d21b7e9b2241b02ad9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2007014ac19df7969713fa487eecb1fedbab6d2914974a033156ec217285a5013b37d4f5fac9fa688c7a85755a9a4aa5d91821f7c500ce58b8be81b5e8ba79c0"} build_url:https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/epI30FBeSfGJNJzGhwreow/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bb95b268cba08076866e22fe62076bfe175ebfb7c87237113f1740a91c85517b21b9ba3704fa4f1e17959c665e4a404dde0665fe8796c482dcac0c9ccb55e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65523abdc6d349136ce5861b06494822de9175aa6615d70163ee0937171907fc3bd6ac3a33da840d4c3d2ecff0e8b7a06be10e15238482cab66cca3db716e1a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/491fab5982ae069d87f4b2c6aed9c03e995d9cdd0ad55f6318f39e04ced133e3f356296bf8a5fa2fed976237ec9604fa90488493c343d21b7e9b2241b02ad9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2007014ac19df7969713fa487eecb1fedbab6d2914974a033156ec217285a5013b37d4f5fac9fa688c7a85755a9a4aa5d91821f7c500ce58b8be81b5e8ba79c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 00:24:15.175302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:24:15.175651) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501646049.361064-958959414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:24:15.257696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 00:24:15.261026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 00:24:15.261307) ========= ========= Total master_lag: -0.03 =========