builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1485733278.81 results: success (0) revision: d859e69475796f76214f07c6d133c3a1f325156c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:18.807840) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:18.808192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:18.808473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:18.825000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:18.825327) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-29 15:41:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.8M=0s 2017-01-29 15:41:19 (35.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:18.949278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:18.949915) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:19.000302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:19.000632) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d859e69475796f76214f07c6d133c3a1f325156c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d859e69475796f76214f07c6d133c3a1f325156c --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=7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-29 15:41:19,511 truncating revision to first 12 chars 2017-01-29 15:41:19,511 Setting DEBUG logging. 2017-01-29 15:41:19,511 attempt 1/10 2017-01-29 15:41:19,511 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d859e6947579?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-29 15:41:19,925 unpacking tar archive at: mozilla-aurora-d859e6947579/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704605 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:19.718041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:19.718333) ========= script_repo_revision: d859e69475796f76214f07c6d133c3a1f325156c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:19.718716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:19.718970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 15:41:19.726858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-29 15:41:19.727174) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:41:20 INFO - MultiFileLogger online at 20170129 15:41:20 in /builds/slave/test 15:41:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:41:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:41:20 INFO - {'append_to_log': False, 15:41:20 INFO - 'base_work_dir': '/builds/slave/test', 15:41:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:41:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:41:20 INFO - 'branch': 'Mozilla-Aurora', 15:41:20 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:20 INFO - 'config_files': ('talos/linux_config.py',), 15:41:20 INFO - 'default_actions': ('clobber', 15:41:20 INFO - 'read-buildbot-config', 15:41:20 INFO - 'download-and-extract', 15:41:20 INFO - 'populate-webroot', 15:41:20 INFO - 'create-virtualenv', 15:41:20 INFO - 'install', 15:41:20 INFO - 'run-tests'), 15:41:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:20 INFO - 'download_minidump_stackwalk': True, 15:41:20 INFO - 'download_symbols': 'ondemand', 15:41:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:20 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:20 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:20 INFO - 'installer_path': 'installer.exe', 15:41:20 INFO - 'log_level': 'info', 15:41:20 INFO - 'log_name': 'talos', 15:41:20 INFO - 'log_to_console': True, 15:41:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:41:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:41:20 INFO - 'opt_config_files': (), 15:41:20 INFO - 'pip_index': False, 15:41:20 INFO - 'sps_profile': False, 15:41:20 INFO - 'sps_profile_interval': 0, 15:41:20 INFO - 'suite': 'dromaeojs', 15:41:20 INFO - 'system_bits': '32', 15:41:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:20 INFO - 'title': 'talos-linux64-ix-005', 15:41:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:20 INFO - 'use_talos_json': True, 15:41:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:41:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:20 INFO - 'work_dir': 'build'} 15:41:20 INFO - [mozharness: 2017-01-29 23:41:20.335298Z] Running clobber step. 15:41:20 INFO - Running pre-action listener: _resource_record_pre_action 15:41:20 INFO - Running main action method: clobber 15:41:20 INFO - rmtree: /builds/slave/test/build 15:41:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:41:20 INFO - Running post-action listener: _resource_record_post_action 15:41:20 INFO - [mozharness: 2017-01-29 23:41:20.808612Z] Finished clobber step (success) 15:41:20 INFO - [mozharness: 2017-01-29 23:41:20.808733Z] Running read-buildbot-config step. 15:41:20 INFO - Running pre-action listener: _resource_record_pre_action 15:41:20 INFO - Running main action method: read_buildbot_config 15:41:20 INFO - Using buildbot properties: 15:41:20 INFO - { 15:41:20 INFO - "project": "", 15:41:20 INFO - "product": "firefox", 15:41:20 INFO - "who": "hikezoe@mozilla.com", 15:41:20 INFO - "installer_path": "public/build/target.tar.bz2", 15:41:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:41:20 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 15:41:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:41:20 INFO - "stage_platform": "linux64-pgo", 15:41:20 INFO - "basedir": "/builds/slave/test", 15:41:20 INFO - "buildnumber": 726, 15:41:20 INFO - "platform": "ubuntu64_hw", 15:41:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:41:20 INFO - "slavebuilddir": "test", 15:41:20 INFO - "taskId": "c2mgYW1FSFGaYmOZA0vToQ", 15:41:20 INFO - "branch": "mozilla-aurora", 15:41:20 INFO - "script_repo_revision": "production", 15:41:20 INFO - "revision": "d859e69475796f76214f07c6d133c3a1f325156c", 15:41:20 INFO - "slavename": "talos-linux64-ix-005", 15:41:20 INFO - "repo_path": "releases/mozilla-aurora" 15:41:20 INFO - } 15:41:20 INFO - Finding installer, test and symbols from parent task. 15:41:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2mgYW1FSFGaYmOZA0vToQ'}, attempt #1 15:41:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2mgYW1FSFGaYmOZA0vToQ'}, attempt #1 15:41:21 INFO - Task dependencies: Khp4t3AcS1aeFMcJLSxTxg 15:41:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg'}, attempt #1 15:41:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2 15:41:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/test_packages.json 15:41:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.crashreporter-symbols.zip 15:41:22 INFO - Running post-action listener: _resource_record_post_action 15:41:22 INFO - [mozharness: 2017-01-29 23:41:22.209949Z] Finished read-buildbot-config step (success) 15:41:22 INFO - [mozharness: 2017-01-29 23:41:22.210165Z] Running download-and-extract step. 15:41:22 INFO - Running pre-action listener: _resource_record_pre_action 15:41:22 INFO - Running main action method: download_and_extract 15:41:22 INFO - mkdir: /builds/slave/test/build/tests 15:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:22 INFO - trying https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.test_packages.json 15:41:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:41:22 INFO - Downloaded 896 bytes. 15:41:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:41:22 INFO - Using the following test package requirements: 15:41:22 INFO - {u'common': [u'target.common.tests.zip'], 15:41:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:41:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:41:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:41:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:41:22 INFO - u'mozbase': [u'target.common.tests.zip'], 15:41:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:41:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:41:22 INFO - u'web-platform': [u'target.common.tests.zip', 15:41:22 INFO - u'target.web-platform.tests.zip'], 15:41:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:41:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:41:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.common.tests.zip 15:41:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:41:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.common.tests.zip into memory 15:41:23 INFO - Expected file size: 21849904 15:41:23 INFO - Obtained file size: 21849904 15:41:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:41:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.common.tests.zip 15:41:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:41:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.common.tests.zip into memory 15:41:28 INFO - Expected file size: 21849904 15:41:28 INFO - Obtained file size: 21849904 15:41:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.talos.tests.zip 15:41:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:41:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.talos.tests.zip into memory 15:41:33 INFO - Expected file size: 14403485 15:41:33 INFO - Obtained file size: 14403485 15:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:34 INFO - trying https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2 15:41:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:41:35 INFO - Downloaded 66094850 bytes. 15:41:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2 15:41:35 INFO - mkdir: /builds/slave/test/properties 15:41:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:41:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:41:35 INFO - Contents: 15:41:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2 15:41:35 INFO - Running post-action listener: _resource_record_post_action 15:41:35 INFO - Running post-action listener: set_extra_try_arguments 15:41:35 INFO - [mozharness: 2017-01-29 23:41:35.185041Z] Finished download-and-extract step (success) 15:41:35 INFO - [mozharness: 2017-01-29 23:41:35.185138Z] Running populate-webroot step. 15:41:35 INFO - Running pre-action listener: _resource_record_pre_action 15:41:35 INFO - Running main action method: populate_webroot 15:41:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:41:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:41:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:41:35 INFO - '--tppagecycles', 15:41:35 INFO - '7'], 15:41:35 INFO - 'tests': ['tsvgm']}}, 15:41:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:41:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:41:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:41:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:41:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:41:35 INFO - 'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:41:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:41:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:41:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:41:35 INFO - 'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['damp', 'tps']}, 15:41:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:41:35 INFO - 'tests': ['damp', 'tps']}, 15:41:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['dromaeo_dom']}, 15:41:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:41:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['basic_compositor_video']}, 15:41:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:41:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['a11yr', 15:41:35 INFO - 'ts_paint', 15:41:35 INFO - 'tpaint', 15:41:35 INFO - 'sessionrestore', 15:41:35 INFO - 'sessionrestore_no_auto_restore', 15:41:35 INFO - 'tabpaint']}, 15:41:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:41:35 INFO - 'ts_paint', 15:41:35 INFO - 'tpaint', 15:41:35 INFO - 'sessionrestore', 15:41:35 INFO - 'sessionrestore_no_auto_restore', 15:41:35 INFO - 'tabpaint']}, 15:41:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:41:35 INFO - 'ts_paint', 15:41:35 INFO - 'tpaint', 15:41:35 INFO - 'sessionrestore', 15:41:35 INFO - 'sessionrestore_no_auto_restore', 15:41:35 INFO - 'tabpaint']}, 15:41:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:41:35 INFO - 'ts_paint', 15:41:35 INFO - 'tpaint', 15:41:35 INFO - 'sessionrestore', 15:41:35 INFO - 'sessionrestore_no_auto_restore', 15:41:35 INFO - 'tabpaint']}, 15:41:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['a11yr', 15:41:35 INFO - 'ts_paint', 15:41:35 INFO - 'tpaint', 15:41:35 INFO - 'sessionrestore', 15:41:35 INFO - 'sessionrestore_no_auto_restore', 15:41:35 INFO - 'tabpaint']}, 15:41:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['a11yr', 15:41:35 INFO - 'ts_paint', 15:41:35 INFO - 'tpaint', 15:41:35 INFO - 'sessionrestore', 15:41:35 INFO - 'sessionrestore_no_auto_restore', 15:41:35 INFO - 'tabpaint']}, 15:41:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['tsvgx', 15:41:35 INFO - 'tsvgr_opacity', 15:41:35 INFO - 'tart', 15:41:35 INFO - 'tscrollx', 15:41:35 INFO - 'cart', 15:41:35 INFO - 'tsvg_static']}, 15:41:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:41:35 INFO - 'tsvgr_opacity', 15:41:35 INFO - 'tart', 15:41:35 INFO - 'tscrollx', 15:41:35 INFO - 'cart', 15:41:35 INFO - 'tsvg_static']}, 15:41:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:41:35 INFO - 'talos_options': ['--disable-e10s'], 15:41:35 INFO - 'tests': ['tp5o']}, 15:41:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:41:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:41:35 INFO - 'talos_options': ['--disable-e10s', 15:41:35 INFO - '--xperf_path', 15:41:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:41:35 INFO - 'tests': ['tp5n']}, 15:41:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:41:35 INFO - 'talos_options': ['--xperf_path', 15:41:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:41:35 INFO - 'tests': ['tp5n']}}, 15:41:35 INFO - 'talos.zip': {'path': '', 15:41:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:41:35 INFO - Running post-action listener: _resource_record_post_action 15:41:35 INFO - [mozharness: 2017-01-29 23:41:35.198321Z] Finished populate-webroot step (success) 15:41:35 INFO - [mozharness: 2017-01-29 23:41:35.198411Z] Running create-virtualenv step. 15:41:35 INFO - Running pre-action listener: _resource_record_pre_action 15:41:35 INFO - Running main action method: create_virtualenv 15:41:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:41:35 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 15:41:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:41:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:41:35 INFO - Using real prefix '/usr' 15:41:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:41:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:41:37 INFO - Installing pip.................done. 15:41:37 INFO - Return code: 0 15:41:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:41:37 INFO - Reading from file tmpfile_stdout 15:41:37 INFO - Output received: 15:41:37 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) 15:41:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:41:37 INFO - Using env: {'DISPLAY': ':0', 15:41:37 INFO - 'HOME': '/home/cltbld', 15:41:37 INFO - 'LANG': 'en_US.UTF-8', 15:41:37 INFO - 'LANGUAGE': 'en_US:en', 15:41:37 INFO - 'LOGNAME': 'cltbld', 15:41:37 INFO - 'MAIL': '/var/mail/cltbld', 15:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:37 INFO - 'MOZ_NO_REMOTE': '1', 15:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:37 INFO - 'NO_EM_RESTART': '1', 15:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:37 INFO - 'PWD': '/builds/slave/test', 15:41:37 INFO - 'SHELL': '/bin/bash', 15:41:37 INFO - 'SHLVL': '1', 15:41:37 INFO - 'TERM': 'linux', 15:41:37 INFO - 'TMOUT': '86400', 15:41:37 INFO - 'USER': 'cltbld', 15:41:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:37 INFO - '_': '/tools/buildbot/bin/python'} 15:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:38 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 15:41:38 INFO - Cleaning up... 15:41:38 INFO - Return code: 0 15:41:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:38 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:41:38 INFO - Using env: {'DISPLAY': ':0', 15:41:38 INFO - 'HOME': '/home/cltbld', 15:41:38 INFO - 'LANG': 'en_US.UTF-8', 15:41:38 INFO - 'LANGUAGE': 'en_US:en', 15:41:38 INFO - 'LOGNAME': 'cltbld', 15:41:38 INFO - 'MAIL': '/var/mail/cltbld', 15:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:38 INFO - 'MOZ_NO_REMOTE': '1', 15:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:38 INFO - 'NO_EM_RESTART': '1', 15:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:38 INFO - 'PWD': '/builds/slave/test', 15:41:38 INFO - 'SHELL': '/bin/bash', 15:41:38 INFO - 'SHLVL': '1', 15:41:38 INFO - 'TERM': 'linux', 15:41:38 INFO - 'TMOUT': '86400', 15:41:38 INFO - 'USER': 'cltbld', 15:41:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:38 INFO - '_': '/tools/buildbot/bin/python'} 15:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:38 INFO - Downloading/unpacking psutil>=3.1.1 15:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:41:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:40 INFO - Installing collected packages: psutil 15:41:40 INFO - Running setup.py install for psutil 15:41:40 INFO - building 'psutil._psutil_linux' extension 15:41:40 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 15:41:40 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 15:41:40 INFO - building 'psutil._psutil_posix' extension 15:41:40 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 15:41:40 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 15:41:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:40 INFO - Successfully installed psutil 15:41:40 INFO - Cleaning up... 15:41:41 INFO - Return code: 0 15:41:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:41:41 INFO - Using env: {'DISPLAY': ':0', 15:41:41 INFO - 'HOME': '/home/cltbld', 15:41:41 INFO - 'LANG': 'en_US.UTF-8', 15:41:41 INFO - 'LANGUAGE': 'en_US:en', 15:41:41 INFO - 'LOGNAME': 'cltbld', 15:41:41 INFO - 'MAIL': '/var/mail/cltbld', 15:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:41 INFO - 'MOZ_NO_REMOTE': '1', 15:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:41 INFO - 'NO_EM_RESTART': '1', 15:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:41 INFO - 'PWD': '/builds/slave/test', 15:41:41 INFO - 'SHELL': '/bin/bash', 15:41:41 INFO - 'SHLVL': '1', 15:41:41 INFO - 'TERM': 'linux', 15:41:41 INFO - 'TMOUT': '86400', 15:41:41 INFO - 'USER': 'cltbld', 15:41:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:41 INFO - '_': '/tools/buildbot/bin/python'} 15:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:41:41 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 15:41:41 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 15:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:41 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 15:41:41 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 15:41:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:41:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:41:43 INFO - Installing collected packages: mozsystemmonitor 15:41:43 INFO - Running setup.py install for mozsystemmonitor 15:41:43 INFO - Successfully installed mozsystemmonitor 15:41:43 INFO - Cleaning up... 15:41:43 INFO - Return code: 0 15:41:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:41:43 INFO - Using env: {'DISPLAY': ':0', 15:41:43 INFO - 'HOME': '/home/cltbld', 15:41:43 INFO - 'LANG': 'en_US.UTF-8', 15:41:43 INFO - 'LANGUAGE': 'en_US:en', 15:41:43 INFO - 'LOGNAME': 'cltbld', 15:41:43 INFO - 'MAIL': '/var/mail/cltbld', 15:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:43 INFO - 'MOZ_NO_REMOTE': '1', 15:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:43 INFO - 'NO_EM_RESTART': '1', 15:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:43 INFO - 'PWD': '/builds/slave/test', 15:41:43 INFO - 'SHELL': '/bin/bash', 15:41:43 INFO - 'SHLVL': '1', 15:41:43 INFO - 'TERM': 'linux', 15:41:43 INFO - 'TMOUT': '86400', 15:41:43 INFO - 'USER': 'cltbld', 15:41:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:43 INFO - '_': '/tools/buildbot/bin/python'} 15:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:43 INFO - Downloading/unpacking jsonschema==2.5.1 15:41:43 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 15:41:43 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 15:41:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:43 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 15:41:43 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 15:41:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:41:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:45 INFO - Downloading functools32-3.2.3-2.tar.gz 15:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:41:45 INFO - warning: no files found matching '*.txt' 15:41:45 INFO - no previously-included directories found matching 'build' 15:41:45 INFO - no previously-included directories found matching 'dist' 15:41:45 INFO - no previously-included directories found matching '.git*' 15:41:45 INFO - Installing collected packages: jsonschema, functools32 15:41:46 INFO - Running setup.py install for functools32 15:41:46 INFO - warning: no files found matching '*.txt' 15:41:46 INFO - no previously-included directories found matching 'build' 15:41:46 INFO - no previously-included directories found matching 'dist' 15:41:46 INFO - no previously-included directories found matching '.git*' 15:41:46 INFO - Successfully installed jsonschema functools32 15:41:46 INFO - Cleaning up... 15:41:46 INFO - Return code: 0 15:41:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:41:46 INFO - Using env: {'DISPLAY': ':0', 15:41:46 INFO - 'HOME': '/home/cltbld', 15:41:46 INFO - 'LANG': 'en_US.UTF-8', 15:41:46 INFO - 'LANGUAGE': 'en_US:en', 15:41:46 INFO - 'LOGNAME': 'cltbld', 15:41:46 INFO - 'MAIL': '/var/mail/cltbld', 15:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:46 INFO - 'MOZ_NO_REMOTE': '1', 15:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:46 INFO - 'NO_EM_RESTART': '1', 15:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:46 INFO - 'PWD': '/builds/slave/test', 15:41:46 INFO - 'SHELL': '/bin/bash', 15:41:46 INFO - 'SHLVL': '1', 15:41:46 INFO - 'TERM': 'linux', 15:41:46 INFO - 'TMOUT': '86400', 15:41:46 INFO - 'USER': 'cltbld', 15:41:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:46 INFO - '_': '/tools/buildbot/bin/python'} 15:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:41:46 INFO - Cleaning up... 15:41:46 INFO - Return code: 0 15:41:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:41:46 INFO - Using env: {'DISPLAY': ':0', 15:41:46 INFO - 'HOME': '/home/cltbld', 15:41:46 INFO - 'LANG': 'en_US.UTF-8', 15:41:46 INFO - 'LANGUAGE': 'en_US:en', 15:41:46 INFO - 'LOGNAME': 'cltbld', 15:41:46 INFO - 'MAIL': '/var/mail/cltbld', 15:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:46 INFO - 'MOZ_NO_REMOTE': '1', 15:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:46 INFO - 'NO_EM_RESTART': '1', 15:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:46 INFO - 'PWD': '/builds/slave/test', 15:41:46 INFO - 'SHELL': '/bin/bash', 15:41:46 INFO - 'SHLVL': '1', 15:41:46 INFO - 'TERM': 'linux', 15:41:46 INFO - 'TMOUT': '86400', 15:41:46 INFO - 'USER': 'cltbld', 15:41:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:46 INFO - '_': '/tools/buildbot/bin/python'} 15:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:41:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:41:48 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 15:41:48 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 15:41:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:48 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 15:41:48 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 15:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:41:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:41:49 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 15:41:49 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 15:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:49 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 15:41:49 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 15:41:49 INFO - Downloading docopt-0.6.1.tar.gz 15:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:41:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:41:49 INFO - Running setup.py install for blobuploader 15:41:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:41:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:41:49 INFO - Running setup.py install for requests 15:41:49 INFO - Running setup.py install for docopt 15:41:49 INFO - Successfully installed blobuploader requests docopt 15:41:49 INFO - Cleaning up... 15:41:50 INFO - Return code: 0 15:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:41:50 INFO - Using env: {'DISPLAY': ':0', 15:41:50 INFO - 'HOME': '/home/cltbld', 15:41:50 INFO - 'LANG': 'en_US.UTF-8', 15:41:50 INFO - 'LANGUAGE': 'en_US:en', 15:41:50 INFO - 'LOGNAME': 'cltbld', 15:41:50 INFO - 'MAIL': '/var/mail/cltbld', 15:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:50 INFO - 'MOZ_NO_REMOTE': '1', 15:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:50 INFO - 'NO_EM_RESTART': '1', 15:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:50 INFO - 'PWD': '/builds/slave/test', 15:41:50 INFO - 'SHELL': '/bin/bash', 15:41:50 INFO - 'SHLVL': '1', 15:41:50 INFO - 'TERM': 'linux', 15:41:50 INFO - 'TMOUT': '86400', 15:41:50 INFO - 'USER': 'cltbld', 15:41:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:50 INFO - '_': '/tools/buildbot/bin/python'} 15:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:41:50 INFO - Running setup.py (path:/tmp/pip-PM6RRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:41:50 INFO - Running setup.py (path:/tmp/pip-J8Lm2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:41:50 INFO - Running setup.py (path:/tmp/pip-O5RptD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:41:50 INFO - Running setup.py (path:/tmp/pip-BSposL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:41:50 INFO - Running setup.py (path:/tmp/pip-kzf2Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:41:50 INFO - Running setup.py (path:/tmp/pip-1tBCoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:41:50 INFO - Running setup.py (path:/tmp/pip-TbItSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:41:50 INFO - Running setup.py (path:/tmp/pip-l8eF0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:41:50 INFO - Running setup.py (path:/tmp/pip-2v4UPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:41:50 INFO - Running setup.py (path:/tmp/pip-hsH_o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:41:51 INFO - Running setup.py (path:/tmp/pip-hMBs_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:41:51 INFO - Running setup.py (path:/tmp/pip-zfuBr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:41:51 INFO - Running setup.py (path:/tmp/pip-cn2xgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:41:51 INFO - Running setup.py (path:/tmp/pip-m7cWAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:51 INFO - Running setup.py (path:/tmp/pip-x4CUjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:41:51 INFO - Running setup.py (path:/tmp/pip-9cQjj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:41:51 INFO - Running setup.py (path:/tmp/pip-xd93PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:41:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:41:51 INFO - Running setup.py install for manifestparser 15:41:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:41:51 INFO - Running setup.py install for mozcrash 15:41:51 INFO - Running setup.py install for mozdebug 15:41:51 INFO - Running setup.py install for mozdevice 15:41:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:41:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:41:51 INFO - Running setup.py install for mozfile 15:41:52 INFO - Running setup.py install for mozhttpd 15:41:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Running setup.py install for mozinfo 15:41:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Running setup.py install for mozInstall 15:41:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Running setup.py install for mozleak 15:41:52 INFO - Running setup.py install for mozlog 15:41:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Running setup.py install for moznetwork 15:41:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Running setup.py install for mozprocess 15:41:52 INFO - Running setup.py install for mozprofile 15:41:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Running setup.py install for mozrunner 15:41:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:41:52 INFO - Running setup.py install for mozscreenshot 15:41:53 INFO - Running setup.py install for moztest 15:41:53 INFO - Running setup.py install for mozversion 15:41:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:41:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:41:53 INFO - Cleaning up... 15:41:53 INFO - Return code: 0 15:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:41:53 INFO - Using env: {'DISPLAY': ':0', 15:41:53 INFO - 'HOME': '/home/cltbld', 15:41:53 INFO - 'LANG': 'en_US.UTF-8', 15:41:53 INFO - 'LANGUAGE': 'en_US:en', 15:41:53 INFO - 'LOGNAME': 'cltbld', 15:41:53 INFO - 'MAIL': '/var/mail/cltbld', 15:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:53 INFO - 'MOZ_NO_REMOTE': '1', 15:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:53 INFO - 'NO_EM_RESTART': '1', 15:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:53 INFO - 'PWD': '/builds/slave/test', 15:41:53 INFO - 'SHELL': '/bin/bash', 15:41:53 INFO - 'SHLVL': '1', 15:41:53 INFO - 'TERM': 'linux', 15:41:53 INFO - 'TMOUT': '86400', 15:41:53 INFO - 'USER': 'cltbld', 15:41:53 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:53 INFO - '_': '/tools/buildbot/bin/python'} 15:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:41:53 INFO - Running setup.py (path:/tmp/pip-Kv3ZSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:41:53 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)) 15:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:41:53 INFO - Running setup.py (path:/tmp/pip-pegT5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:41:53 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)) 15:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:41:53 INFO - Running setup.py (path:/tmp/pip-e57gpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:41:53 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)) 15:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:41:53 INFO - Running setup.py (path:/tmp/pip-idGdtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:41:53 INFO - Running setup.py (path:/tmp/pip-gmE7fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:41:53 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)) 15:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:41:53 INFO - Running setup.py (path:/tmp/pip-uoSy10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:41:53 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)) 15:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:41:53 INFO - Running setup.py (path:/tmp/pip-CxZ3fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:41:54 INFO - Running setup.py (path:/tmp/pip-vfNoXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:41:54 INFO - Running setup.py (path:/tmp/pip-Dky_o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:41:54 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)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:41:54 INFO - Running setup.py (path:/tmp/pip-WJGDZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:41:54 INFO - Running setup.py (path:/tmp/pip-PRODRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:41:54 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)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:41:54 INFO - Running setup.py (path:/tmp/pip-78FBIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:41:54 INFO - Running setup.py (path:/tmp/pip-gBAIzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:41:54 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)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:41:54 INFO - Running setup.py (path:/tmp/pip-jJ2xZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:41:54 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)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:54 INFO - Running setup.py (path:/tmp/pip-qaKRNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:54 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)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:41:54 INFO - Running setup.py (path:/tmp/pip-4SOhzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:41:54 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)) 15:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:41:54 INFO - Running setup.py (path:/tmp/pip-gqnV_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:41:54 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)) 15:41:54 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)) 15:41:54 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)) 15:41:54 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)) 15:41:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:41: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 15:41: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 15:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41: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 15:41: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 15:41:56 INFO - Downloading blessings-1.6.tar.gz 15:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:41:56 INFO - Installing collected packages: blessings 15:41:56 INFO - Running setup.py install for blessings 15:41:56 INFO - Successfully installed blessings 15:41:56 INFO - Cleaning up... 15:41:57 INFO - Return code: 0 15:41:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:41:57 INFO - Reading from file tmpfile_stdout 15:41:57 INFO - Current package versions: 15:41:57 INFO - argparse == 1.2.1 15:41:57 INFO - blessings == 1.6 15:41:57 INFO - blobuploader == 1.2.4 15:41:57 INFO - docopt == 0.6.1 15:41:57 INFO - functools32 == 3.2.3-2 15:41:57 INFO - jsonschema == 2.5.1 15:41:57 INFO - manifestparser == 1.1 15:41:57 INFO - mozInstall == 1.12 15:41:57 INFO - mozcrash == 1.0 15:41:57 INFO - mozdebug == 0.1 15:41:57 INFO - mozdevice == 0.49 15:41:57 INFO - mozfile == 1.2 15:41:57 INFO - mozhttpd == 0.7 15:41:57 INFO - mozinfo == 0.9 15:41:57 INFO - mozleak == 0.1 15:41:57 INFO - mozlog == 3.4 15:41:57 INFO - moznetwork == 0.27 15:41:57 INFO - mozprocess == 0.24 15:41:57 INFO - mozprofile == 0.28 15:41:57 INFO - mozrunner == 6.13 15:41:57 INFO - mozscreenshot == 0.1 15:41:57 INFO - mozsystemmonitor == 0.3 15:41:57 INFO - moztest == 0.8 15:41:57 INFO - mozversion == 1.4 15:41:57 INFO - psutil == 3.1.1 15:41:57 INFO - requests == 1.2.3 15:41:57 INFO - wsgiref == 0.1.2 15:41:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:41:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:41:57 INFO - Using env: {'DISPLAY': ':0', 15:41:57 INFO - 'HOME': '/home/cltbld', 15:41:57 INFO - 'LANG': 'en_US.UTF-8', 15:41:57 INFO - 'LANGUAGE': 'en_US:en', 15:41:57 INFO - 'LOGNAME': 'cltbld', 15:41:57 INFO - 'MAIL': '/var/mail/cltbld', 15:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:57 INFO - 'MOZ_NO_REMOTE': '1', 15:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:57 INFO - 'NO_EM_RESTART': '1', 15:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:57 INFO - 'PWD': '/builds/slave/test', 15:41:57 INFO - 'SHELL': '/bin/bash', 15:41:57 INFO - 'SHLVL': '1', 15:41:57 INFO - 'TERM': 'linux', 15:41:57 INFO - 'TMOUT': '86400', 15:41:57 INFO - 'USER': 'cltbld', 15:41:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:57 INFO - '_': '/tools/buildbot/bin/python'} 15:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 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)) 15:41:57 INFO - Cleaning up... 15:41:57 INFO - Return code: 0 15:41:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', '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 15:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:41:57 INFO - Using env: {'DISPLAY': ':0', 15:41:57 INFO - 'HOME': '/home/cltbld', 15:41:57 INFO - 'LANG': 'en_US.UTF-8', 15:41:57 INFO - 'LANGUAGE': 'en_US:en', 15:41:57 INFO - 'LOGNAME': 'cltbld', 15:41:57 INFO - 'MAIL': '/var/mail/cltbld', 15:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:57 INFO - 'MOZ_NO_REMOTE': '1', 15:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:57 INFO - 'NO_EM_RESTART': '1', 15:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:57 INFO - 'PWD': '/builds/slave/test', 15:41:57 INFO - 'SHELL': '/bin/bash', 15:41:57 INFO - 'SHLVL': '1', 15:41:57 INFO - 'TERM': 'linux', 15:41:57 INFO - 'TMOUT': '86400', 15:41:57 INFO - 'USER': 'cltbld', 15:41:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:57 INFO - '_': '/tools/buildbot/bin/python'} 15:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:41:57 INFO - Cleaning up... 15:41:57 INFO - Return code: 0 15:41:57 INFO - Running post-action listener: _resource_record_post_action 15:41:57 INFO - Running post-action listener: _start_resource_monitoring 15:41:57 INFO - Starting resource monitoring. 15:41:57 INFO - [mozharness: 2017-01-29 23:41:57.753119Z] Finished create-virtualenv step (success) 15:41:57 INFO - [mozharness: 2017-01-29 23:41:57.753636Z] Running install step. 15:41:57 INFO - Running pre-action listener: _resource_record_pre_action 15:41:57 INFO - Running main action method: install 15:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:41:57 INFO - Reading from file tmpfile_stdout 15:41:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:41:58 INFO - Reading from file tmpfile_stdout 15:41:58 INFO - Output received: 15:41:58 INFO - Usage: mozinstall [options] installer 15:41:58 INFO - Options: 15:41:58 INFO - -h, --help show this help message and exit 15:41:58 INFO - -d DEST, --destination=DEST 15:41:58 INFO - Directory to install application into. [default: 15:41:58 INFO - "/builds/slave/test"] 15:41:58 INFO - --app=APP Application being installed. [default: firefox] 15:41:58 INFO - mkdir: /builds/slave/test/build/application 15:41:58 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'] 15:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:42:14 INFO - Reading from file tmpfile_stdout 15:42:14 INFO - Output received: 15:42:14 INFO - /builds/slave/test/build/application/firefox/firefox 15:42:14 INFO - Running post-action listener: _resource_record_post_action 15:42:14 INFO - [mozharness: 2017-01-29 23:42:14.631510Z] Finished install step (success) 15:42:14 INFO - [mozharness: 2017-01-29 23:42:14.631788Z] Running run-tests step. 15:42:14 INFO - Running pre-action listener: _resource_record_pre_action 15:42:14 INFO - Running main action method: run_tests 15:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:42:14 INFO - Python 2.7.3 15:42:14 INFO - Return code: 0 15:42:14 INFO - grabbing minidump binary from tooltool 15:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:42:14 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 0x23bb850>, '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 0x23306d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2330b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:42:14 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 15:42:14 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 15:42:14 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 15:42:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:42:14 INFO - Return code: 0 15:42:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:42:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:42:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:42:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:42:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:42:14 INFO - Using env: {'DISPLAY': ':0', 15:42:14 INFO - 'HOME': '/home/cltbld', 15:42:14 INFO - 'LANG': 'en_US.UTF-8', 15:42:14 INFO - 'LANGUAGE': 'en_US:en', 15:42:14 INFO - 'LOGNAME': 'cltbld', 15:42:14 INFO - 'MAIL': '/var/mail/cltbld', 15:42:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:42:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:14 INFO - 'MOZ_NO_REMOTE': '1', 15:42:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:14 INFO - 'NO_EM_RESTART': '1', 15:42:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:14 INFO - 'PWD': '/builds/slave/test', 15:42:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:42:14 INFO - 'SHELL': '/bin/bash', 15:42:14 INFO - 'SHLVL': '1', 15:42:14 INFO - 'TERM': 'linux', 15:42:14 INFO - 'TMOUT': '86400', 15:42:14 INFO - 'USER': 'cltbld', 15:42:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790', 15:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:14 INFO - '_': '/tools/buildbot/bin/python'} 15:42:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:42:14 INFO - mozversion application_buildid: 20170129224458 15:42:14 INFO - mozversion application_changeset: d859e69475796f76214f07c6d133c3a1f325156c 15:42:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:42:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:42:14 INFO - mozversion application_name: Firefox 15:42:14 INFO - mozversion application_remotingname: firefox-dev 15:42:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:42:14 INFO - mozversion application_vendor: Mozilla 15:42:14 INFO - mozversion application_version: 53.0a2 15:42:14 INFO - mozversion platform_buildid: 20170129224458 15:42:14 INFO - mozversion platform_changeset: d859e69475796f76214f07c6d133c3a1f325156c 15:42:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:42:14 INFO - mozversion platform_version: 53.0a2 15:42:14 INFO - using testdate: 1485733334 15:42:14 INFO - actual date: 1485733334 15:42:14 INFO - starting webserver on 'localhost:41654' 15:42:14 INFO - SUITE-START | Running 2 tests 15:42:14 INFO - TEST-START | dromaeo_css 15:42:14 INFO - operating with platform_type : linux_ 15:42:14 INFO - Initialising browser for dromaeo_css test... 15:42:14 INFO - TEST-INFO | started process 21601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1YZ7oG/profile http://localhost:41654/getInfo.html) 15:42:18 INFO - PROCESS | 21601 | __metrics Screen width/height:1600/1200 15:42:18 INFO - PROCESS | 21601 | colorDepth:24 15:42:18 INFO - PROCESS | 21601 | Browser inner width/height: 1024/697 15:42:18 INFO - PROCESS | 21601 | __metrics 15:42:19 INFO - PROCESS | 21601 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:42:19 INFO - PROCESS | 21601 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:42:19 INFO - PROCESS | 21601 | console.error: PushService: 15:42:19 INFO - PROCESS | 21601 | stateChangeProcessEnqueue: Error transitioning state 15:42:19 INFO - PROCESS | 21601 | UnknownError 15:42:20 INFO - TEST-INFO | 21601: exit 0 15:42:20 INFO - Browser initialized. 15:42:20 INFO - Running cycle 1/1 for dromaeo_css test... 15:42:20 INFO - TEST-INFO | started process 21690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1YZ7oG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:32 INFO - PROCESS | 21690 | RSS: Main: 138002432 15:42:32 INFO - PROCESS | 21690 | 15:45:32 INFO - PROCESS | 21690 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41654/tests/dromaeo/cssquery-ext.html) 15:45:33 INFO - PROCESS | 21690 | RSS: Main: 243417088 15:45:33 INFO - PROCESS | 21690 | 15:47:22 INFO - PROCESS | 21690 | ************************* 15:47:22 INFO - PROCESS | 21690 | A coding exception was thrown and uncaught in a Task. 15:47:22 INFO - PROCESS | 21690 | 15:47:22 ERROR - PROCESS | 21690 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:47:22 INFO - PROCESS | 21690 | Full stack: 15:47:22 INFO - PROCESS | 21690 | ************************* 15:48:36 INFO - PROCESS | 21690 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-ext.html (next: http://localhost:41654/tests/dromaeo/cssquery-jquery.html) 15:48:36 INFO - PROCESS | 21690 | RSS: Main: 221999104 15:48:36 INFO - PROCESS | 21690 | 15:51:38 INFO - PROCESS | 21690 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41654/tests/dromaeo/cssquery-mootools.html) 15:51:39 INFO - PROCESS | 21690 | RSS: Main: 169934848 15:51:39 INFO - PROCESS | 21690 | 15:54:41 INFO - PROCESS | 21690 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41654/tests/dromaeo/cssquery-prototype.html) 15:54:41 INFO - PROCESS | 21690 | RSS: Main: 214622208 15:54:41 INFO - PROCESS | 21690 | 15:57:44 INFO - PROCESS | 21690 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41654/tests/dromaeo/cssquery-yui.html) 15:57:44 INFO - PROCESS | 21690 | RSS: Main: 171794432 15:57:44 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-yui.html (next: http://localhost:41654/tests/dromaeo/cssquery-dojo.html) 16:00:47 INFO - PROCESS | 21690 | RSS: Main: 260669440 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | __start_tp_report 16:00:47 INFO - PROCESS | 21690 | _x_x_mozilla_page_load 16:00:47 INFO - PROCESS | 21690 | _x_x_mozilla_page_load_details 16:00:47 INFO - PROCESS | 21690 | |i|pagename|runs| 16:00:47 INFO - PROCESS | 21690 | |0;dojo.html;3192.80843149411;3212.0685001349593;3240;3242.5136229565546;3255.1373885920234;5317.308749862517;5391.137418013119;5426.158945363465;5434.157705555635;5460.918086228699;5398.082326004579;5403.891922161554;5421.051316019701;5425.213344065108;5429.429909859467;4911.091448082098;4927.384076990376;4938.950610493903;4960.3303554020285;4982.402111746595;4881.072596206727;4907.2639104134305;4910.435299940499;4946;5025.3718285214345;4886.609071274307;4959.032988567231;4993.675411098285;5003.47463516331;5005.54950054495;4988.077205716936;4991.800327986876;4995.300657907859;4999.60003199745;5028.547430731252;4787.329773831666;4804.95195048052;4930.260460930853;4944.653874228806;4981.452040275567;5327.520523152934;5373.328333958255;5386.165144402624;5414.593905457106;5458.044842152647;5817.272840894888;5821.592488525805;5827.533797296206;5834.4165583441745;5850.502707269887;5744.310682718059;5835.212246346731;5847.561767556171;5879.735411906475;5896.882062358772;5358.5981051421295;5376.489233522848;5380.488853558905;5410.945890541084;5466.262054622575;5859.589828711949;5860.472557469848;5863.2670916135485;5868.823935281948;5869.882602347929;5655.943440565624;5664.0937450007805;5666.631668941505;5668.348139963874;5668.773249069991;5689.6586204827845;5709.486146246858;5721.998650236192;5722.599418040697;5739.253896993448;5741.397153298927;5784.88430231393;5791.391903850119;5798.420157984252;5822.272215973004;5747.770089196469;5785.884282314414;5793.478586927196;5805.88388232233;5809.215755872988;4414.977925110354;4457.977710111429;4465.1962646723905;4494.797734101973;4502.212112880233;4017.216642754693;4029;4038.818253178555;4043.8786836394956;4066.1257829566784;5627.268455100811;5631.211630371751;5632.549396048306;5632.915506267409;5633;5706.771729130871;5737.196792449061;5742.540596752333;5763;5775.624584402;5588.189712491747;5593.328800543879;5593.692346920959;5594.412586678422;5627.099664053731;4971.925421118686;4972.950270497321;4973.278874563241;4975.850724478271;5005.249212618136;5817.3019237690905;5842.182094506772;5988.431099045583;6041.78853740117;6052.182955300978;5828.854278643068;5833.154192641959;5834.795782147605;5854.970725146347;5872.706364681663;6001.06983417571;6020.187274717857;6024.849378765391;6033.54748393881;6118.694065296629;5507.311586051744;5543.1408131739645;5629.915551266652;5787.94212057874;5788.652680839163;5729.598928074995;5802.1586869902785;5834.241548598825;5835.533157347317;5846.152307915243;5548.778048878;5630.60585758993;5641.069223578228;5649.265595472727;5650.124230744241;5450.482204190595;5618.2134501170685;5620.213170156099;5625.915611265752;5629.605927585029;5544.778208871761;5566.554675625859;5589.189567512769;5594.300712410949;5676.517496012885;5664.631798933056;5673.262475878109;5679.176519404746;5682.374938756816;5688.971555142198;5613.158026296088;5619.915701264403;5624.29696287964;5625.21247025425;5626.409227031267 16:00:47 INFO - PROCESS | 21690 | |1;ext.html;567.7331654122563;603.131490653459;614.9392298285458;624.8594066335072;692.5533031194876;36976.44535331972;47507.287390689125;48988.51011489884;49033.50966490334;49056.75471622646;51235.48764512354;51675.741621291934;51776;51843.48156518434;51851.22223166656;8839.513826739527;9311.534423278827;9492.857607135898;9495.145436910676;9498.952505237465;8758;11173.162012849029;11408.429578521082;11422.657320280363;11817.231879927776;11044.502997365098;11064.723381915477;11084.722881927935;11098.55605775768;11114.944425277863;11455.427228638535;11457.59898403556;11526.71183220422;11526.884731152664;11539.48072336747;11281.210315277935;11309.321440713502;11320.886791132065;11355.14836387266;11355.489002994886;48312.516874831505;49002.7549862252;49129.754351228374;49130.26304605434;49194.01611967776;4527.977360113211;4551.294549344857;4591.724496530185;4711.175544279771;4718.764061796931;34950.82524587361;35524.64475355239;35722;36178.457323140174;36698.816505917566;3262.7879187852714;3311.503274508819;3316.8341582920757;3333.0834020644274;3489.180042689966;351650;352186;353355;353806.99999999744;354658;69289;69398;69669.30330696628;69793;69826.65086674535;73529;73858;73939.63030184814;74031;74088.25911740813;19652;20282.087306071262;20305.898470507553;20313.695294570593;20329.288474903602;13093.869061309455;13255.138416002928;15500.30248638814;15966.840331596535;16066.598335041717;18770.718439223423;19036.71444928327;19062.14220360087;19240.134193961305;19321.806781932002;6601.768938087144;6613.735450581923;6674.365935236145;6690.632015239111;6727.058211850345;993.7366597851575;1006.2402885821305;1008.0876806490138;1010.888802231754;1018.2312354172552;33431.3313733724;33785.493217601754;34036.14909627279;34747.4787878182;34832.129196770285;1185.585045234161;1188.2217147768226;1224.8285240066398;1233.1306428967737;1298.3902356263977;18210.18054187565;18252.54368640768;18319.35882244115;18342.724859127124;18386.80485768421;459910;460556;461604;461619;464497;69585.65207173931;69796.30203697897;69827.30172698208;70055.29944700589;70100.64949675219;1534.1025500082576;1548.883833712476;1565.2017471089598;1598.057146283698;1605.3016937632167;31920.680793191772;33562.664373355954;33703.83148084244;33783.32433351369;34103.31793364069;58197;59582.40417595769;59642;59653;59703.70148149232;387212;387410;387518;387973;388845;44248.336274955254;44434;49852.50147498478;50548.490100361494;51024.489755101975;50012;57318.42681573298;57676.71161644165;58059.129113062496;58481.4151858493;46221.306680399146;48619.99960373222;49020.5097949016;49065.75467122784;49297.50702492929;45012.77493612511;47749.522504774504;47895.52104478911;48132;49519.75240123776;45548.31677524774;48761;49278;49998.750006249735;50230.497695024045;40517.59482405138;42459.1508169841;42990.78504607457;43239;43353.783231083646;30805.383892322476;30858.69141308648;31220.68779312178;31300.06099817009;31344.686553134175 16:00:47 INFO - PROCESS | 21690 | |2;jquery.html;432.92856678648025;437.4881388775133;446.4107378260695;450.2143759140301;452.52710917091656;20454;21087.2619458319;22274.220402285922;22443.32670019902;22507.32478025658;21875.12499500018;22594.322170334875;22870.77129228707;22959.885200573975;23211.883940580316;6031.728572214239;6075.63546187228;6279.717412716416;6285.591436556632;6287.339829317924;6034.336223015464;6079.422454866781;6109.847253818646;6114.908276375858;6127.632342059491;5908.261467316585;6065.878682426371;6075.119107729377;6082.0268756998885;6162.352952939944;6128.38716128388;6154.04612285092;6164.599301045418;6166.105914642397;6169.537284703621;5501.559875209973;5505.532029777473;5535.418781027975;5544;5553.16702494629;26099.608505872427;26328.21015369542;26420.20739377822;26474.6028809568;26568.601470977952;2921.3426978929783;3000.534917087855;3017.4719424100913;3045.482268014443;3081.2142903559447;16160.595985100466;16256.349746010146;16321.428749993693;16342.34630614774;16377.590560236089;2050.507878109258;2051.558914833318;2063;2063.9277625283194;2068.11071239367;62333.44166395831;78837;80608.19391806066;91179;95161.52419237998;10689;11587.942060289644;11809.940950295366;11983.16117871758;11990.280583164864;15725;16244.593885152966;16397.098159601097;16418.343266269454;17311.3941012064;8797.12028797128;8964.372493925363;9050.637974481078;9103.499307538017;9124.954375228213;8623.655053797904;8652.826943461096;8690.08754080825;8840.823183536293;8849.51327676971;7549.396048316122;7609.695612175562;7629.931809546668;7782.221777822286;7804.804879877935;2109.578084383099;2129.254760833696;2144.4638840289927;2145.495808485005;2177.901994410255;965.8164948659872;972.7227740094039;973.600823662295;1011.1708399112657;1012.8430093335545;21500.569988600142;22256.888715556317;22306.996185171705;22337;22437.887810560842;993.7565296502403;998.3410948773775;1003.663772636175;1020.8009438159636;1027.409239687183;11615.825762613567;12365.134440589252;12445.439955202037;12458.81311780324;12551.686207844694;659002;673294;685318;689676;720248;73763.63118184375;89625.55187224022;90591;90732;90880;1176.817593273044;1187.3350923482876;1213.0538180219266;1216.3978830479145;1218.0620921890095;18666.719999200293;18892;19041.24971926268;19091.522711932314;19129.234830607176;42065.15869682528;42365.78817105895;42683;43784.90537736582;43949.78025109854;58787.11819322628;61223;62000.37999619946;68677;72597;6933.618650974043;9344.252459803336;9583.65828783957;9683.806323873623;9711.465869377253;11309.886901130883;13253.536126235536;13510.459581617019;14181.14913105217;14203.928980355033;10570.2600817942;11824.172307938361;11914.702132446411;12709.04682148824;12887.291198984145;12425.689357766129;12916.935415322863;13041.608751737464;13156.144850584682;13506.797398039234;13020.088593798344;13066.412011459697;13172.143810652276;13181.934090329487;13482.056256061982;9186;9549.713508594754;9591.376560523544;9688.273379496706;9692.079252471003;11242.718932026437;12201.328926909106;12306.876931230574;12392;12609.369531523571 16:00:47 INFO - PROCESS | 21690 | |3;mootools.html;1486.3905798622568;1503.4812989518625;1518.7569988801795;1519.6808670179262;1538.961525961851;8095.392845536586;8560.10118937512;8566.314694824414;8574.69988550401;8574.957125214381;7723.922760772391;7959.7612071637795;8133.511989280647;8395.496270223792;8405.369597280198;2410.457647029422;2422.685050943384;2426.38127277544;2430.586800243963;2436.488337449138;2448.3879030242438;2474.4679893822827;2490.489449662815;2496.5506208882393;2502.51201015802;2150.4408853698073;2227.498812767131;2335.7664233576593;2415.6618073469726;2420.4311986683115;2448.902043918241;2450.5956517174645;2467.9876600617063;2474.455619763658;2474.715407728116;2407.41018450479;2434.6226334918115;2470.197185914585;2504.8747562621797;2509.146890057371;8481.321494280442;8610.311175105977;8633.697820576312;8634.697785577475;8648.567571621394;5314.335708036496;5474.753636086386;5478.04134276504;5482.80810171646;5489.368722596872;3360.865565377382;3380.138064793462;3413.8634454621783;3440.4667276572172;3503.5095086687884;1386.431563059141;1398.175076704749;1427.9500217492339;1434.2326855132558;1450.8259008918892;10799.460026998697;11296.096312295078;11319.830202546967;11353.829692554618;11375.317480951087;4732.041049030822;4742.1227072991605;4802.903941921142;4830.29960655703;4849.733264670477;9799.902000980042;9803.362781419184;9806.460644664612;9814.754631134136;9822.65620703272;5526.336839579196;5570.3315602128005;5578.9163162552595;5588.413216612197;5590.049691552445;4864.343313652683;4937.432195297515;5205.141151710001;5257.158854583248;5258.684478931276;3848.9230215396096;3898.2203559288255;3909.670711957891;3935.2916475034767;3958.247932892741;1114.1198453221864;1189.4052973513244;1199.7240634654079;1212.9514819407125;1215.6535387414722;891.7324802559207;1021.3106153346462;1035.4305132177271;1041.2763129624989;1041.9479026048666;5811.593188476851;5902.409759024149;5923.585349025527;5943.435373639497;6027.095935609606;1083.6099004358425;1100.0309446091567;1100.7688385438987;1109.866815982071;1118.59730497021;3893.162969961472;3993.8602148924647;4114.362273847559;4120.990357362405;4126.628603425706;9821.656242031495;10124.443155626512;10233.795324093626;10242.48787560619;10261.384316941007;10060.74848128788;10070.848937265946;10146.746331341628;10147.543360548792;10167.898321016843;7950.363970882316;8068.112507624157;8079.434439589172;8085.191480851985;8085.514869107872;5522.944770552243;5551.333839939233;5598.468145526169;5623.156526521055;5692.1461780733225;9095.135962083592;9324.440533568008;9358.906410935804;9473;9491;9194.862077068983;9543.90456095458;9594.952025239829;9663.565139568596;9767.218622510325;7827.882581761164;7892.921070789448;7919.247671471201;7995.520268783892;8001.319887809602;8079.87880181786;8146.389020823343;8149.877751833608;8150.144234855492;8150.673973041012;7236.819079523054;7540.698372065056;7577.621118944141;7587.317141457295;7624.428167887541;7491.475596708397;7516.962415187889;7549.7357592483995;7562.546247225184;7604.8479030417975;6475.028745688184;6536;6557.704903279268;6560.27836937946;6580.934190658224;4955.430125535466;4961.900761984668;5030.748462576783;5031.169856973705;5210.088234559013;4981.62637802159;4983.07813054586;5003.824866129668;5005.949940500694;5112.335396398445 16:00:47 INFO - PROCESS | 21690 | |4;prototype.html;410.4315523000643;418.4267553451771;421.4394854843059;426.9615734583888;430.70711915897215;5401.513863752261;5417.214503896942;5426.15894536347;5438.265834112399;5451.155070963997;5130.434782608696;5262.289590905227;5267.657602255851;5275.419703832576;5415.891682166364;4221.24017676818;4253.55337689542;4330.415393921828;4357.3899654048455;4358.6730995175485;4336.804843782037;4341.869743907688;4352.782360881959;4364.127174565099;4397.714148580348;4274.935875961863;4354.303311470166;4374.825006999717;4381.079973205615;4388.67084968627;4340.175366680352;4341.413909122291;4356.346548017823;4367.388565600819;4378.8029538670835;3996.300647386725;4003.11931375097;4007.8196481158416;4009.3985902114914;4018.296798060357;5179.119549676527;5267.920981185247;5273.947260527384;5300.946990530084;5307.469253074701;5019;5020.723860187688;5031.949680503221;5033.697978121288;5050.898982020339;5679.290088738908;5683.715814209273;5688.374278829326;5691.260136182311;5706.629069110494;4285.700000999931;4395.604395604379;4430.335449682541;4434.60088592025;4448.154850578379;5867.354590994987;5880.382559831199;5888.205092312526;5895.911561326584;5907.291125064977;4542.454905411372;4577.862664120082;4584.633229341644;4587.334836448763;4591.517890621503;4434.689571729948;4595.908081838412;4616.838410655678;4624.329472226508;4626.0979109073405;4995.150824359867;5004.199328107558;5007.874803129951;5017.89964200714;5072.695638261716;5650.124230744241;5688.63023903445;5706.600537962386;5735.598508104476;5737.655740655574;1463.370750577262;1475.7343678138038;1524.4588171199287;1526.770984352334;1534.9539513814605;1031.5306535526317;1066.5627092892032;1093.283899046126;1104.4643347976225;1107.5348353691309;5340.332458442695;5410.729463526808;5421.322334708161;5438.8912221755345;5440.4287549807495;5256.5269125778095;5596.27248457706;5598.216249725042;5598.944010559923;5687.630304030225;5346.198070289488;5357.303550538405;5357.946420535744;5364.31784107946;5399.463351504771;2934.3691106411798;2936.515474946653;2951.4764876031113;2968.6289213848268;2986.656534498517;5528.170774383874;5782.421757824184;5806.564507661942;5845.357010728816;5846.035404158351;5643.012472817322;5668.9716551417805;5681.857953551194;5683.431656834367;5729.8772169167905;5744.253247077937;5784.363719990798;5808.738606762621;5831.4168583141345;5841;5467.371252306036;5767.5674324425;5776.393478684846;5778.94221057784;5791.218185544897;5699.5725320600295;5702.173184888251;5713.600047996601;5716.971415143064;5793.449622285876;5866.530677545701;6010.9699451502465;6029.854327677727;6063.818085457443;6080.817575472743;4257.765822879772;4277.700560960703;4308;4308.935365969451;4309.762963037063;5838.912416313844;5927;5928.347881733092;5946.226990491208;5946.524278057832;5475.233467314659;5635.605507614428;5674.914876276942;5681;5774.181132943109;5647.05176714033;5665.988574056316;5668.37647858727;5668.688222147822;5669.461401166883;5404.32445944257;5479.561635069264;5544.916826247529;5609.635373700697;5658.40586738403;5607.897038610521;5650;5683.772649094155;5690.772369105355;5691.658500489983;5483.550843527255;5489.670619762827;5560.972195138998;5605.598600349913;5606.6636001840025 16:00:47 INFO - PROCESS | 21690 | |5;yui.html;815.9061707903589;819.7622689420068;858.6779957515931;914.8581969794682;931.4876817750236;16569.25438355274;17553.73669394957;18016.4595062148;18046.72929906051;18087.72868406975;15294.464693735721;15376.461823836167;15419.537413877602;15425.845741542582;15456.22718864055;710.2329484157124;713.0730050933792;806.4395245304515;818.1327792539897;837.5644664774313;828.9336853051772;837.9078301386843;843.7047033538274;844.501743971057;845.4251109245711;892.4511425473352;893.3255392178896;894;894.2711689972684;894.306912143091;736.3078706016381;742.5655991245128;854.1543871567104;877.2455688108222;880.7930136417937;639.1403562208822;642.5662677692538;643.1253495246461;643.3373625166087;643.6009674002102;16776.161191940355;16790.328386864512;16822.411215607517;16852.24164912582;17324.22041008145;15146.5456036318;16043.919780401024;16057.759133613004;16251.187440627922;16356.672866542722;14200.715985680332;14283.285835708173;14288.714225715532;14299.070560413644;14325.498607548685;4543.477500087499;4579.22153233951;4589.449266088058;4604.102200070987;4683.88290292742;80752;82375.17624823735;83347;84968;85675.57162214149;11798.941005294919;11934.104942129376;11985.28088314704;12003.219790713576;12185;22631.094756209895;22643;22672.206472773374;22796.772032279467;22886.885565572065;8335.249827515432;8410.663573457115;8411;8431.873521897176;8607.096254893271;4575.702579332333;4674.088552732184;4684.0866031123605;4735.857924262277;4835.879103022453;3637.181634132352;3723.925521489555;3728.422094575345;3731.1418373774186;3732.2162345907122;622.3651875087476;626.3173141276031;628.230417738267;639.7313128485954;645.1773988165033;809.223145780046;818.3126174013738;821.7165078048064;829.8298848735994;830.8552130187333;10583.100436462833;10672.573097076185;10772.676819695422;11035.503402346914;11119;746.7722344684923;754.9886751698729;772.3396495995955;780.683823051665;786.3551887452235;4880.707157570557;5497.120460726264;5780.826575202751;5869.148973398833;5879.764809407661;65134.34865651378;68246.65876670585;78022.60988695134;78321.21678783139;78846.60576697194;49037;58605.41394586085;60244.69877650584;61496;62676.373236267056;55887.44112558904;56884.43115568791;57268;57804;58496;11122.777544449227;11421.828672570084;11561.901619346148;11710.648680539598;11764.35296058725;40185.79907100446;40592.1881562373;40635.1872962545;40701;41568.376474353514;47847.41144414113;52060.47939520556;52130;52664.47335526596;54962;13561.593152205449;13670.316484175553;13783.51757688476;13807.102538334975;13989.090709103875;15397;15409.152496612794;15680.843191568394;15706.450274240347;15937;14502.202378868842;14709.92645036768;14795.260236988323;14972.7005459888;15041.774373384627;14613.780793287897;14842.554723358317;14852.904574642667;15178.468753593572;15704.450344237897;14564.660055249346;14611;14880.479183228535;15159.545213643609;15389;11229.27009744364;11327.490262938352;11484.94257528707;11735.002524785488;11939.880601193878;11441.370724610226;11682.649520514398;11958.10314226454;11960.222585531912;12014.939925300318 16:00:47 INFO - PROCESS | 21690 | __end_tp_report 16:00:47 INFO - PROCESS | 21690 | __start_cc_report 16:00:47 INFO - PROCESS | 21690 | _x_x_mozilla_cycle_collect,927 16:00:47 INFO - PROCESS | 21690 | __end_cc_report 16:00:47 INFO - PROCESS | 21690 | __startTimestamp1485734447643__endTimestamp 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | ------- Summary: start ------- 16:00:47 INFO - PROCESS | 21690 | Number of tests: 6 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | [#0] dojo.html Cycles:165 Average:5391.93 Median:5625.21 stddev:588.79 (10.5%) stddev-sans-first:564.76 16:00:47 INFO - PROCESS | 21690 | Values: 3192.8 3212.1 3240.0 3242.5 3255.1 5317.3 5391.1 5426.2 5434.2 5460.9 5398.1 5403.9 5421.1 5425.2 5429.4 4911.1 4927.4 4939.0 4960.3 4982.4 4881.1 4907.3 4910.4 4946.0 5025.4 4886.6 4959.0 4993.7 5003.5 5005.5 4988.1 4991.8 4995.3 4999.6 5028.5 4787.3 4805.0 4930.3 4944.7 4981.5 5327.5 5373.3 5386.2 5414.6 5458.0 5817.3 5821.6 5827.5 5834.4 5850.5 5744.3 5835.2 5847.6 5879.7 5896.9 5358.6 5376.5 5380.5 5410.9 5466.3 5859.6 5860.5 5863.3 5868.8 5869.9 5655.9 5664.1 5666.6 5668.3 5668.8 5689.7 5709.5 5722.0 5722.6 5739.3 5741.4 5784.9 5791.4 5798.4 5822.3 5747.8 5785.9 5793.5 5805.9 5809.2 4415.0 4458.0 4465.2 4494.8 4502.2 4017.2 4029.0 4038.8 4043.9 4066.1 5627.3 5631.2 5632.5 5632.9 5633.0 5706.8 5737.2 5742.5 5763.0 5775.6 5588.2 5593.3 5593.7 5594.4 5627.1 4971.9 4973.0 4973.3 4975.9 5005.2 5817.3 5842.2 5988.4 6041.8 6052.2 5828.9 5833.2 5834.8 5855.0 5872.7 6001.1 6020.2 6024.8 6033.5 6118.7 5507.3 5543.1 5629.9 5787.9 5788.7 5729.6 5802.2 5834.2 5835.5 5846.2 5548.8 5630.6 5641.1 5649.3 5650.1 5450.5 5618.2 5620.2 5625.9 5629.6 5544.8 5566.6 5589.2 5594.3 5676.5 5664.6 5673.3 5679.2 5682.4 5689.0 5613.2 5619.9 5624.3 5625.2 5626.4 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | [#1] ext.html Cycles:180 Average:60943.68 Median:42724.97 stddev:105871.39 (247.8%) stddev-sans-first:106071.34 16:00:47 INFO - PROCESS | 21690 | Values: 567.7 603.1 614.9 624.9 692.6 36976.4 47507.3 48988.5 49033.5 49056.8 51235.5 51675.7 51776.0 51843.5 51851.2 8839.5 9311.5 9492.9 9495.1 9499.0 8758.0 11173.2 11408.4 11422.7 11817.2 11044.5 11064.7 11084.7 11098.6 11114.9 11455.4 11457.6 11526.7 11526.9 11539.5 11281.2 11309.3 11320.9 11355.1 11355.5 48312.5 49002.8 49129.8 49130.3 49194.0 4528.0 4551.3 4591.7 4711.2 4718.8 34950.8 35524.6 35722.0 36178.5 36698.8 3262.8 3311.5 3316.8 3333.1 3489.2 351650.0 352186.0 353355.0 353807.0 354658.0 69289.0 69398.0 69669.3 69793.0 69826.7 73529.0 73858.0 73939.6 74031.0 74088.3 19652.0 20282.1 20305.9 20313.7 20329.3 13093.9 13255.1 15500.3 15966.8 16066.6 18770.7 19036.7 19062.1 19240.1 19321.8 6601.8 6613.7 6674.4 6690.6 6727.1 993.7 1006.2 1008.1 1010.9 1018.2 33431.3 33785.5 34036.1 34747.5 34832.1 1185.6 1188.2 1224.8 1233.1 1298.4 18210.2 18252.5 18319.4 18342.7 18386.8 459910.0 460556.0 461604.0 461619.0 464497.0 69585.7 69796.3 69827.3 70055.3 70100.6 1534.1 1548.9 1565.2 1598.1 1605.3 31920.7 33562.7 33703.8 33783.3 34103.3 58197.0 59582.4 59642.0 59653.0 59703.7 387212.0 387410.0 387518.0 387973.0 388845.0 44248.3 44434.0 49852.5 50548.5 51024.5 50012.0 57318.4 57676.7 58059.1 58481.4 46221.3 48620.0 49020.5 49065.8 49297.5 45012.8 47749.5 47895.5 48132.0 49519.8 45548.3 48761.0 49278.0 49998.8 50230.5 40517.6 42459.2 42990.8 43239.0 43353.8 30805.4 30858.7 31220.7 31300.1 31344.7 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | [#2] jquery.html Cycles:180 Average:35526.73 Median:2960.94 stddev:112133.23 (3787.1%) stddev-sans-first:112416.83 16:00:47 INFO - PROCESS | 21690 | Values: 432.9 437.5 446.4 450.2 452.5 20454.0 21087.3 22274.2 22443.3 22507.3 21875.1 22594.3 22870.8 22959.9 23211.9 6031.7 6075.6 6279.7 6285.6 6287.3 6034.3 6079.4 6109.8 6114.9 6127.6 5908.3 6065.9 6075.1 6082.0 6162.4 6128.4 6154.0 6164.6 6166.1 6169.5 5501.6 5505.5 5535.4 5544.0 5553.2 26099.6 26328.2 26420.2 26474.6 26568.6 2921.3 3000.5 3017.5 3045.5 3081.2 16160.6 16256.3 16321.4 16342.3 16377.6 2050.5 2051.6 2063.0 2063.9 2068.1 62333.4 78837.0 80608.2 91179.0 95161.5 10689.0 11587.9 11809.9 11983.2 11990.3 15725.0 16244.6 16397.1 16418.3 17311.4 8797.1 8964.4 9050.6 9103.5 9125.0 8623.7 8652.8 8690.1 8840.8 8849.5 7549.4 7609.7 7629.9 7782.2 7804.8 2109.6 2129.3 2144.5 2145.5 2177.9 965.8 972.7 973.6 1011.2 1012.8 21500.6 22256.9 22307.0 22337.0 22437.9 993.8 998.3 1003.7 1020.8 1027.4 11615.8 12365.1 12445.4 12458.8 12551.7 659002.0 673294.0 685318.0 689676.0 720248.0 73763.6 89625.6 90591.0 90732.0 90880.0 1176.8 1187.3 1213.1 1216.4 1218.1 18666.7 18892.0 19041.2 19091.5 19129.2 42065.2 42365.8 42683.0 43784.9 43949.8 58787.1 61223.0 62000.4 68677.0 72597.0 6933.6 9344.3 9583.7 9683.8 9711.5 11309.9 13253.5 13510.5 14181.1 14203.9 10570.3 11824.2 11914.7 12709.0 12887.3 12425.7 12916.9 13041.6 13156.1 13506.8 13020.1 13066.4 13172.1 13181.9 13482.1 9186.0 9549.7 9591.4 9688.3 9692.1 11242.7 12201.3 12306.9 12392.0 12609.4 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | [#3] mootools.html Cycles:180 Average:5648.76 Median:5018.35 stddev:3023.00 (60.2%) stddev-sans-first:3015.29 16:00:47 INFO - PROCESS | 21690 | Values: 1486.4 1503.5 1518.8 1519.7 1539.0 8095.4 8560.1 8566.3 8574.7 8575.0 7723.9 7959.8 8133.5 8395.5 8405.4 2410.5 2422.7 2426.4 2430.6 2436.5 2448.4 2474.5 2490.5 2496.6 2502.5 2150.4 2227.5 2335.8 2415.7 2420.4 2448.9 2450.6 2468.0 2474.5 2474.7 2407.4 2434.6 2470.2 2504.9 2509.1 8481.3 8610.3 8633.7 8634.7 8648.6 5314.3 5474.8 5478.0 5482.8 5489.4 3360.9 3380.1 3413.9 3440.5 3503.5 1386.4 1398.2 1428.0 1434.2 1450.8 10799.5 11296.1 11319.8 11353.8 11375.3 4732.0 4742.1 4802.9 4830.3 4849.7 9799.9 9803.4 9806.5 9814.8 9822.7 5526.3 5570.3 5578.9 5588.4 5590.0 4864.3 4937.4 5205.1 5257.2 5258.7 3848.9 3898.2 3909.7 3935.3 3958.2 1114.1 1189.4 1199.7 1213.0 1215.7 891.7 1021.3 1035.4 1041.3 1041.9 5811.6 5902.4 5923.6 5943.4 6027.1 1083.6 1100.0 1100.8 1109.9 1118.6 3893.2 3993.9 4114.4 4121.0 4126.6 9821.7 10124.4 10233.8 10242.5 10261.4 10060.7 10070.8 10146.7 10147.5 10167.9 7950.4 8068.1 8079.4 8085.2 8085.5 5522.9 5551.3 5598.5 5623.2 5692.1 9095.1 9324.4 9358.9 9473.0 9491.0 9194.9 9543.9 9595.0 9663.6 9767.2 7827.9 7892.9 7919.2 7995.5 8001.3 8079.9 8146.4 8149.9 8150.1 8150.7 7236.8 7540.7 7577.6 7587.3 7624.4 7491.5 7517.0 7549.7 7562.5 7604.8 6475.0 6536.0 6557.7 6560.3 6580.9 4955.4 4961.9 5030.7 5031.2 5210.1 4981.6 4983.1 5003.8 5005.9 5112.3 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | [#4] prototype.html Cycles:180 Average:4819.17 Median:5400.49 stddev:1344.95 (24.9%) stddev-sans-first:1307.39 16:00:47 INFO - PROCESS | 21690 | Values: 410.4 418.4 421.4 427.0 430.7 5401.5 5417.2 5426.2 5438.3 5451.2 5130.4 5262.3 5267.7 5275.4 5415.9 4221.2 4253.6 4330.4 4357.4 4358.7 4336.8 4341.9 4352.8 4364.1 4397.7 4274.9 4354.3 4374.8 4381.1 4388.7 4340.2 4341.4 4356.3 4367.4 4378.8 3996.3 4003.1 4007.8 4009.4 4018.3 5179.1 5267.9 5273.9 5300.9 5307.5 5019.0 5020.7 5031.9 5033.7 5050.9 5679.3 5683.7 5688.4 5691.3 5706.6 4285.7 4395.6 4430.3 4434.6 4448.2 5867.4 5880.4 5888.2 5895.9 5907.3 4542.5 4577.9 4584.6 4587.3 4591.5 4434.7 4595.9 4616.8 4624.3 4626.1 4995.2 5004.2 5007.9 5017.9 5072.7 5650.1 5688.6 5706.6 5735.6 5737.7 1463.4 1475.7 1524.5 1526.8 1535.0 1031.5 1066.6 1093.3 1104.5 1107.5 5340.3 5410.7 5421.3 5438.9 5440.4 5256.5 5596.3 5598.2 5598.9 5687.6 5346.2 5357.3 5357.9 5364.3 5399.5 2934.4 2936.5 2951.5 2968.6 2986.7 5528.2 5782.4 5806.6 5845.4 5846.0 5643.0 5669.0 5681.9 5683.4 5729.9 5744.3 5784.4 5808.7 5831.4 5841.0 5467.4 5767.6 5776.4 5778.9 5791.2 5699.6 5702.2 5713.6 5717.0 5793.4 5866.5 6011.0 6029.9 6063.8 6080.8 4257.8 4277.7 4308.0 4308.9 4309.8 5838.9 5927.0 5928.3 5946.2 5946.5 5475.2 5635.6 5674.9 5681.0 5774.2 5647.1 5666.0 5668.4 5668.7 5669.5 5404.3 5479.6 5544.9 5609.6 5658.4 5607.9 5650.0 5683.8 5690.8 5691.7 5483.6 5489.7 5561.0 5605.6 5606.7 16:00:47 INFO - PROCESS | 21690 | 16:00:47 INFO - PROCESS | 21690 | [#5] yui.html Cycles:180 Average:17621.16 Median:4559.59 stddev:21189.95 (464.7%) stddev-sans-first:21211.81 16:00:47 INFO - PROCESS | 21690 | Values: 815.9 819.8 858.7 914.9 931.5 16569.3 17553.7 18016.5 18046.7 18087.7 15294.5 15376.5 15419.5 15425.8 15456.2 710.2 713.1 806.4 818.1 837.6 828.9 837.9 843.7 844.5 845.4 892.5 893.3 894.0 894.3 894.3 736.3 742.6 854.2 877.2 880.8 639.1 642.6 643.1 643.3 643.6 16776.2 16790.3 16822.4 16852.2 17324.2 15146.5 16043.9 16057.8 16251.2 16356.7 14200.7 14283.3 14288.7 14299.1 14325.5 4543.5 4579.2 4589.4 4604.1 4683.9 80752.0 82375.2 83347.0 84968.0 85675.6 11798.9 11934.1 11985.3 12003.2 12185.0 22631.1 22643.0 22672.2 22796.8 22886.9 8335.2 8410.7 8411.0 8431.9 8607.1 4575.7 4674.1 4684.1 4735.9 4835.9 3637.2 3723.9 3728.4 3731.1 3732.2 622.4 626.3 628.2 639.7 645.2 809.2 818.3 821.7 829.8 830.9 10583.1 10672.6 10772.7 11035.5 11119.0 746.8 755.0 772.3 780.7 786.4 4880.7 5497.1 5780.8 5869.1 5879.8 65134.3 68246.7 78022.6 78321.2 78846.6 49037.0 58605.4 60244.7 61496.0 62676.4 55887.4 56884.4 57268.0 57804.0 58496.0 11122.8 11421.8 11561.9 11710.6 11764.4 40185.8 40592.2 40635.2 40701.0 41568.4 47847.4 52060.5 52130.0 52664.5 54962.0 13561.6 13670.3 13783.5 13807.1 13989.1 15397.0 15409.2 15680.8 15706.5 15937.0 14502.2 14709.9 14795.3 14972.7 15041.8 14613.8 14842.6 14852.9 15178.5 15704.5 14564.7 14611.0 14880.5 15159.5 15389.0 11229.3 11327.5 11484.9 11735.0 11939.9 11441.4 11682.6 11958.1 11960.2 12014.9 16:00:47 INFO - PROCESS | 21690 | -------- Summary: end -------- 16:00:47 INFO - PROCESS | 21690 | 16:00:48 INFO - TEST-INFO | 21690: exit 0 16:00:48 INFO - TEST-OK | dromaeo_css | took 1113500ms 16:00:48 INFO - TEST-START | kraken 16:00:48 INFO - operating with platform_type : linux_ 16:00:48 INFO - Initialising browser for kraken test... 16:00:48 INFO - TEST-INFO | started process 22007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpApbsCq/profile http://localhost:41654/getInfo.html) 16:00:52 INFO - PROCESS | 22007 | __metrics Screen width/height:1600/1200 16:00:52 INFO - PROCESS | 22007 | colorDepth:24 16:00:52 INFO - PROCESS | 22007 | Browser inner width/height: 1024/697 16:00:52 INFO - PROCESS | 22007 | __metrics 16:00:52 INFO - PROCESS | 22007 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:00:52 INFO - PROCESS | 22007 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:00:53 INFO - PROCESS | 22007 | console.error: PushService: 16:00:53 INFO - PROCESS | 22007 | stateChangeProcessEnqueue: Error transitioning state 16:00:53 INFO - PROCESS | 22007 | UnknownError 16:00:54 INFO - TEST-INFO | 22007: exit 0 16:00:54 INFO - Browser initialized. 16:00:54 INFO - Running cycle 1/1 for kraken test... 16:00:54 INFO - TEST-INFO | started process 22096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpApbsCq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:05 INFO - PROCESS | 22096 | RSS: Main: 137564160 16:01:05 INFO - PROCESS | 22096 | 16:01:08 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-beat-detection) 16:01:09 INFO - PROCESS | 22096 | RSS: Main: 181985280 16:01:09 INFO - PROCESS | 22096 | 16:01:11 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-dft) 16:01:12 INFO - PROCESS | 22096 | RSS: Main: 171491328 16:01:12 INFO - PROCESS | 22096 | 16:01:15 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-fft) 16:01:15 INFO - PROCESS | 22096 | RSS: Main: 263716864 16:01:15 INFO - PROCESS | 22096 | 16:01:17 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-oscillator) 16:01:18 INFO - PROCESS | 22096 | RSS: Main: 170348544 16:01:18 INFO - PROCESS | 22096 | 16:01:20 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:01:21 INFO - PROCESS | 22096 | RSS: Main: 172072960 16:01:21 INFO - PROCESS | 22096 | 16:01:24 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41654/tests/kraken/driver.html?testName=imaging-darkroom) 16:01:24 INFO - PROCESS | 22096 | RSS: Main: 211169280 16:01:24 INFO - PROCESS | 22096 | 16:01:28 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41654/tests/kraken/driver.html?testName=imaging-desaturate) 16:01:28 INFO - PROCESS | 22096 | RSS: Main: 210059264 16:01:28 INFO - PROCESS | 22096 | 16:01:31 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41654/tests/kraken/driver.html?testName=json-parse-financial) 16:01:32 INFO - PROCESS | 22096 | RSS: Main: 207831040 16:01:32 INFO - PROCESS | 22096 | 16:01:33 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:01:34 INFO - PROCESS | 22096 | RSS: Main: 170684416 16:01:34 INFO - PROCESS | 22096 | 16:01:35 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:01:36 INFO - PROCESS | 22096 | RSS: Main: 177614848 16:01:36 INFO - PROCESS | 22096 | 16:01:38 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:01:38 INFO - PROCESS | 22096 | RSS: Main: 186912768 16:01:38 INFO - PROCESS | 22096 | 16:01:41 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:01:42 INFO - PROCESS | 22096 | RSS: Main: 196104192 16:01:42 INFO - PROCESS | 22096 | 16:01:44 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:01:45 INFO - PROCESS | 22096 | RSS: Main: 192942080 16:01:45 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41654/tests/kraken/driver.html?testName=ai-astar) 16:01:47 INFO - PROCESS | 22096 | RSS: Main: 243810304 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | __start_tp_report 16:01:47 INFO - PROCESS | 22096 | _x_x_mozilla_page_load 16:01:47 INFO - PROCESS | 22096 | _x_x_mozilla_page_load_details 16:01:47 INFO - PROCESS | 22096 | |i|pagename|runs| 16:01:47 INFO - PROCESS | 22096 | |0;ai-astar;110;111;112;112;112;112;112;112;112;112 16:01:47 INFO - PROCESS | 22096 | |1;audio-beat-detection;145;118;121;155;120;119;118;116;137;123 16:01:47 INFO - PROCESS | 22096 | |2;audio-dft;162;161;163;162;161;162;160;161;159;159 16:01:47 INFO - PROCESS | 22096 | |3;audio-fft;74;76;76;109;76;76;84;76;98;76 16:01:47 INFO - PROCESS | 22096 | |4;audio-oscillator;83;82;117;83;83;83;100;82;82;104 16:01:47 INFO - PROCESS | 22096 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;116;117;116 16:01:47 INFO - PROCESS | 22096 | |6;imaging-darkroom;146;147;147;147;148;147;146;147;146;147 16:01:47 INFO - PROCESS | 22096 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;95;96 16:01:47 INFO - PROCESS | 22096 | |8;json-parse-financial;50;49;49;48;48;49;49;49;50;48 16:01:47 INFO - PROCESS | 22096 | |9;json-stringify-tinderbox;63;63;65;63;64;63;63;64;63;64 16:01:47 INFO - PROCESS | 22096 | |10;stanford-crypto-aes;76;76;78;76;76;76;75;77;75;76 16:01:47 INFO - PROCESS | 22096 | |11;stanford-crypto-ccm;129;127;120;121;126;123;126;129;163;123 16:01:47 INFO - PROCESS | 22096 | |12;stanford-crypto-pbkdf2;157;157;157;162;157;158;159;156;161;164 16:01:47 INFO - PROCESS | 22096 | |13;stanford-crypto-sha256-iterative;65;60;60;64;60;60;61;60;59;61 16:01:47 INFO - PROCESS | 22096 | __end_tp_report 16:01:47 INFO - PROCESS | 22096 | __start_cc_report 16:01:47 INFO - PROCESS | 22096 | _x_x_mozilla_cycle_collect,1545 16:01:47 INFO - PROCESS | 22096 | __end_cc_report 16:01:47 INFO - PROCESS | 22096 | __startTimestamp1485734507380__endTimestamp 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | ------- Summary: start ------- 16:01:47 INFO - PROCESS | 22096 | Number of tests: 14 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.67 (0.6%) stddev-sans-first:0.33 16:01:47 INFO - PROCESS | 22096 | Values: 110.0 111.0 112.0 112.0 112.0 112.0 112.0 112.0 112.0 112.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:122.00 stddev:13.56 (11.1%) stddev-sans-first:12.76 16:01:47 INFO - PROCESS | 22096 | Values: 145.0 118.0 121.0 155.0 120.0 119.0 118.0 116.0 137.0 123.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.33 (0.8%) stddev-sans-first:1.36 16:01:47 INFO - PROCESS | 22096 | Values: 162.0 161.0 163.0 162.0 161.0 162.0 160.0 161.0 159.0 159.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:11.87 (15.6%) stddev-sans-first:12.23 16:01:47 INFO - PROCESS | 22096 | Values: 74.0 76.0 76.0 109.0 76.0 76.0 84.0 76.0 98.0 76.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.50 stddev:12.53 (15.2%) stddev-sans-first:13.04 16:01:47 INFO - PROCESS | 22096 | Values: 83.0 82.0 117.0 83.0 83.0 83.0 100.0 82.0 82.0 104.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 16:01:47 INFO - PROCESS | 22096 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 116.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:01:47 INFO - PROCESS | 22096 | Values: 146.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:01:47 INFO - PROCESS | 22096 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:0.74 (1.5%) stddev-sans-first:0.67 16:01:47 INFO - PROCESS | 22096 | Values: 50.0 49.0 49.0 48.0 48.0 49.0 49.0 49.0 50.0 48.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 16:01:47 INFO - PROCESS | 22096 | Values: 63.0 63.0 65.0 63.0 64.0 63.0 63.0 64.0 63.0 64.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:0.88 (1.2%) stddev-sans-first:0.93 16:01:47 INFO - PROCESS | 22096 | Values: 76.0 76.0 78.0 76.0 76.0 76.0 75.0 77.0 75.0 76.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:126.50 stddev:12.45 (9.8%) stddev-sans-first:13.20 16:01:47 INFO - PROCESS | 22096 | Values: 129.0 127.0 120.0 121.0 126.0 123.0 126.0 129.0 163.0 123.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:158.50 stddev:2.66 (1.7%) stddev-sans-first:2.74 16:01:47 INFO - PROCESS | 22096 | Values: 157.0 157.0 157.0 162.0 157.0 158.0 159.0 156.0 161.0 164.0 16:01:47 INFO - PROCESS | 22096 | 16:01:47 INFO - PROCESS | 22096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:60.50 stddev:1.94 (3.2%) stddev-sans-first:1.42 16:01:47 INFO - PROCESS | 22096 | Values: 65.0 60.0 60.0 64.0 60.0 60.0 61.0 60.0 59.0 61.0 16:01:47 INFO - PROCESS | 22096 | -------- Summary: end -------- 16:01:47 INFO - PROCESS | 22096 | 16:01:48 INFO - TEST-INFO | 22096: exit 0 16:01:48 INFO - TEST-OK | kraken | took 60030ms 16:01:48 INFO - SUITE-END | took 1173s 16:01:48 INFO - Completed test suite (00:19:33) 16:01:48 INFO - javascript benchmark 16:01:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3192.80843149411, 3212.0685001349593, 3240.0, 3242.5136229565546, 3255.1373885920234, 5317.308749862517, 5391.137418013119, 5426.158945363465, 5434.157705555635, 5460.918086228699, 5398.082326004579, 5403.891922161554, 5421.051316019701, 5425.213344065108, 5429.429909859467, 4911.091448082098, 4927.384076990376, 4938.950610493903, 4960.3303554020285, 4982.402111746595, 4881.072596206727, 4907.2639104134305, 4910.435299940499, 4946.0, 5025.3718285214345, 4886.609071274307, 4959.032988567231, 4993.675411098285, 5003.47463516331, 5005.54950054495, 4988.077205716936, 4991.800327986876, 4995.300657907859, 4999.60003199745, 5028.547430731252, 4787.329773831666, 4804.95195048052, 4930.260460930853, 4944.653874228806, 4981.452040275567, 5327.520523152934, 5373.328333958255, 5386.165144402624, 5414.593905457106, 5458.044842152647, 5817.272840894888, 5821.592488525805, 5827.533797296206, 5834.4165583441745, 5850.502707269887, 5744.310682718059, 5835.212246346731, 5847.561767556171, 5879.735411906475, 5896.882062358772, 5358.5981051421295, 5376.489233522848, 5380.488853558905, 5410.945890541084, 5466.262054622575, 5859.589828711949, 5860.472557469848, 5863.2670916135485, 5868.823935281948, 5869.882602347929, 5655.943440565624, 5664.0937450007805, 5666.631668941505, 5668.348139963874, 5668.773249069991, 5689.6586204827845, 5709.486146246858, 5721.998650236192, 5722.599418040697, 5739.253896993448, 5741.397153298927, 5784.88430231393, 5791.391903850119, 5798.420157984252, 5822.272215973004, 5747.770089196469, 5785.884282314414, 5793.478586927196, 5805.88388232233, 5809.215755872988, 4414.977925110354, 4457.977710111429, 4465.1962646723905, 4494.797734101973, 4502.212112880233, 4017.216642754693, 4029.0, 4038.818253178555, 4043.8786836394956, 4066.1257829566784, 5627.268455100811, 5631.211630371751, 5632.549396048306, 5632.915506267409, 5633.0, 5706.771729130871, 5737.196792449061, 5742.540596752333, 5763.0, 5775.624584402, 5588.189712491747, 5593.328800543879, 5593.692346920959, 5594.412586678422, 5627.099664053731, 4971.925421118686, 4972.950270497321, 4973.278874563241, 4975.850724478271, 5005.249212618136, 5817.3019237690905, 5842.182094506772, 5988.431099045583, 6041.78853740117, 6052.182955300978, 5828.854278643068, 5833.154192641959, 5834.795782147605, 5854.970725146347, 5872.706364681663, 6001.06983417571, 6020.187274717857, 6024.849378765391, 6033.54748393881, 6118.694065296629, 5507.311586051744, 5543.1408131739645, 5629.915551266652, 5787.94212057874, 5788.652680839163, 5729.598928074995, 5802.1586869902785, 5834.241548598825, 5835.533157347317, 5846.152307915243, 5548.778048878, 5630.60585758993, 5641.069223578228, 5649.265595472727, 5650.124230744241, 5450.482204190595, 5618.2134501170685, 5620.213170156099, 5625.915611265752, 5629.605927585029, 5544.778208871761, 5566.554675625859, 5589.189567512769, 5594.300712410949, 5676.517496012885, 5664.631798933056, 5673.262475878109, 5679.176519404746, 5682.374938756816, 5688.971555142198, 5613.158026296088, 5619.915701264403, 5624.29696287964, 5625.21247025425, 5626.409227031267], "value": 5354.022143554379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.7331654122563, 603.131490653459, 614.9392298285458, 624.8594066335072, 692.5533031194876, 36976.44535331972, 47507.287390689125, 48988.51011489884, 49033.50966490334, 49056.75471622646, 51235.48764512354, 51675.741621291934, 51776.0, 51843.48156518434, 51851.22223166656, 8839.513826739527, 9311.534423278827, 9492.857607135898, 9495.145436910676, 9498.952505237465, 8758.0, 11173.162012849029, 11408.429578521082, 11422.657320280363, 11817.231879927776, 11044.502997365098, 11064.723381915477, 11084.722881927935, 11098.55605775768, 11114.944425277863, 11455.427228638535, 11457.59898403556, 11526.71183220422, 11526.884731152664, 11539.48072336747, 11281.210315277935, 11309.321440713502, 11320.886791132065, 11355.14836387266, 11355.489002994886, 48312.516874831505, 49002.7549862252, 49129.754351228374, 49130.26304605434, 49194.01611967776, 4527.977360113211, 4551.294549344857, 4591.724496530185, 4711.175544279771, 4718.764061796931, 34950.82524587361, 35524.64475355239, 35722.0, 36178.457323140174, 36698.816505917566, 3262.7879187852714, 3311.503274508819, 3316.8341582920757, 3333.0834020644274, 3489.180042689966, 351650.0, 352186.0, 353355.0, 353806.99999999744, 354658.0, 69289.0, 69398.0, 69669.30330696628, 69793.0, 69826.65086674535, 73529.0, 73858.0, 73939.63030184814, 74031.0, 74088.25911740813, 19652.0, 20282.087306071262, 20305.898470507553, 20313.695294570593, 20329.288474903602, 13093.869061309455, 13255.138416002928, 15500.30248638814, 15966.840331596535, 16066.598335041717, 18770.718439223423, 19036.71444928327, 19062.14220360087, 19240.134193961305, 19321.806781932002, 6601.768938087144, 6613.735450581923, 6674.365935236145, 6690.632015239111, 6727.058211850345, 993.7366597851575, 1006.2402885821305, 1008.0876806490138, 1010.888802231754, 1018.2312354172552, 33431.3313733724, 33785.493217601754, 34036.14909627279, 34747.4787878182, 34832.129196770285, 1185.585045234161, 1188.2217147768226, 1224.8285240066398, 1233.1306428967737, 1298.3902356263977, 18210.18054187565, 18252.54368640768, 18319.35882244115, 18342.724859127124, 18386.80485768421, 459910.0, 460556.0, 461604.0, 461619.0, 464497.0, 69585.65207173931, 69796.30203697897, 69827.30172698208, 70055.29944700589, 70100.64949675219, 1534.1025500082576, 1548.883833712476, 1565.2017471089598, 1598.057146283698, 1605.3016937632167, 31920.680793191772, 33562.664373355954, 33703.83148084244, 33783.32433351369, 34103.31793364069, 58197.0, 59582.40417595769, 59642.0, 59653.0, 59703.70148149232, 387212.0, 387410.0, 387518.0, 387973.0, 388845.0, 44248.336274955254, 44434.0, 49852.50147498478, 50548.490100361494, 51024.489755101975, 50012.0, 57318.42681573298, 57676.71161644165, 58059.129113062496, 58481.4151858493, 46221.306680399146, 48619.99960373222, 49020.5097949016, 49065.75467122784, 49297.50702492929, 45012.77493612511, 47749.522504774504, 47895.52104478911, 48132.0, 49519.75240123776, 45548.31677524774, 48761.0, 49278.0, 49998.750006249735, 50230.497695024045, 40517.59482405138, 42459.1508169841, 42990.78504607457, 43239.0, 43353.783231083646, 30805.383892322476, 30858.69141308648, 31220.68779312178, 31300.06099817009, 31344.686553134175], "value": 22523.02252808468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.92856678648025, 437.4881388775133, 446.4107378260695, 450.2143759140301, 452.52710917091656, 20454.0, 21087.2619458319, 22274.220402285922, 22443.32670019902, 22507.32478025658, 21875.12499500018, 22594.322170334875, 22870.77129228707, 22959.885200573975, 23211.883940580316, 6031.728572214239, 6075.63546187228, 6279.717412716416, 6285.591436556632, 6287.339829317924, 6034.336223015464, 6079.422454866781, 6109.847253818646, 6114.908276375858, 6127.632342059491, 5908.261467316585, 6065.878682426371, 6075.119107729377, 6082.0268756998885, 6162.352952939944, 6128.38716128388, 6154.04612285092, 6164.599301045418, 6166.105914642397, 6169.537284703621, 5501.559875209973, 5505.532029777473, 5535.418781027975, 5544.0, 5553.16702494629, 26099.608505872427, 26328.21015369542, 26420.20739377822, 26474.6028809568, 26568.601470977952, 2921.3426978929783, 3000.534917087855, 3017.4719424100913, 3045.482268014443, 3081.2142903559447, 16160.595985100466, 16256.349746010146, 16321.428749993693, 16342.34630614774, 16377.590560236089, 2050.507878109258, 2051.558914833318, 2063.0, 2063.9277625283194, 2068.11071239367, 62333.44166395831, 78837.0, 80608.19391806066, 91179.0, 95161.52419237998, 10689.0, 11587.942060289644, 11809.940950295366, 11983.16117871758, 11990.280583164864, 15725.0, 16244.593885152966, 16397.098159601097, 16418.343266269454, 17311.3941012064, 8797.12028797128, 8964.372493925363, 9050.637974481078, 9103.499307538017, 9124.954375228213, 8623.655053797904, 8652.826943461096, 8690.08754080825, 8840.823183536293, 8849.51327676971, 7549.396048316122, 7609.695612175562, 7629.931809546668, 7782.221777822286, 7804.804879877935, 2109.578084383099, 2129.254760833696, 2144.4638840289927, 2145.495808485005, 2177.901994410255, 965.8164948659872, 972.7227740094039, 973.600823662295, 1011.1708399112657, 1012.8430093335545, 21500.569988600142, 22256.888715556317, 22306.996185171705, 22337.0, 22437.887810560842, 993.7565296502403, 998.3410948773775, 1003.663772636175, 1020.8009438159636, 1027.409239687183, 11615.825762613567, 12365.134440589252, 12445.439955202037, 12458.81311780324, 12551.686207844694, 659002.0, 673294.0, 685318.0, 689676.0, 720248.0, 73763.63118184375, 89625.55187224022, 90591.0, 90732.0, 90880.0, 1176.817593273044, 1187.3350923482876, 1213.0538180219266, 1216.3978830479145, 1218.0620921890095, 18666.719999200293, 18892.0, 19041.24971926268, 19091.522711932314, 19129.234830607176, 42065.15869682528, 42365.78817105895, 42683.0, 43784.90537736582, 43949.78025109854, 58787.11819322628, 61223.0, 62000.37999619946, 68677.0, 72597.0, 6933.618650974043, 9344.252459803336, 9583.65828783957, 9683.806323873623, 9711.465869377253, 11309.886901130883, 13253.536126235536, 13510.459581617019, 14181.14913105217, 14203.928980355033, 10570.2600817942, 11824.172307938361, 11914.702132446411, 12709.04682148824, 12887.291198984145, 12425.689357766129, 12916.935415322863, 13041.608751737464, 13156.144850584682, 13506.797398039234, 13020.088593798344, 13066.412011459697, 13172.143810652276, 13181.934090329487, 13482.056256061982, 9186.0, 9549.713508594754, 9591.376560523544, 9688.273379496706, 9692.079252471003, 11242.718932026437, 12201.328926909106, 12306.876931230574, 12392.0, 12609.369531523571], "value": 10280.34631018693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.3905798622568, 1503.4812989518625, 1518.7569988801795, 1519.6808670179262, 1538.961525961851, 8095.392845536586, 8560.10118937512, 8566.314694824414, 8574.69988550401, 8574.957125214381, 7723.922760772391, 7959.7612071637795, 8133.511989280647, 8395.496270223792, 8405.369597280198, 2410.457647029422, 2422.685050943384, 2426.38127277544, 2430.586800243963, 2436.488337449138, 2448.3879030242438, 2474.4679893822827, 2490.489449662815, 2496.5506208882393, 2502.51201015802, 2150.4408853698073, 2227.498812767131, 2335.7664233576593, 2415.6618073469726, 2420.4311986683115, 2448.902043918241, 2450.5956517174645, 2467.9876600617063, 2474.455619763658, 2474.715407728116, 2407.41018450479, 2434.6226334918115, 2470.197185914585, 2504.8747562621797, 2509.146890057371, 8481.321494280442, 8610.311175105977, 8633.697820576312, 8634.697785577475, 8648.567571621394, 5314.335708036496, 5474.753636086386, 5478.04134276504, 5482.80810171646, 5489.368722596872, 3360.865565377382, 3380.138064793462, 3413.8634454621783, 3440.4667276572172, 3503.5095086687884, 1386.431563059141, 1398.175076704749, 1427.9500217492339, 1434.2326855132558, 1450.8259008918892, 10799.460026998697, 11296.096312295078, 11319.830202546967, 11353.829692554618, 11375.317480951087, 4732.041049030822, 4742.1227072991605, 4802.903941921142, 4830.29960655703, 4849.733264670477, 9799.902000980042, 9803.362781419184, 9806.460644664612, 9814.754631134136, 9822.65620703272, 5526.336839579196, 5570.3315602128005, 5578.9163162552595, 5588.413216612197, 5590.049691552445, 4864.343313652683, 4937.432195297515, 5205.141151710001, 5257.158854583248, 5258.684478931276, 3848.9230215396096, 3898.2203559288255, 3909.670711957891, 3935.2916475034767, 3958.247932892741, 1114.1198453221864, 1189.4052973513244, 1199.7240634654079, 1212.9514819407125, 1215.6535387414722, 891.7324802559207, 1021.3106153346462, 1035.4305132177271, 1041.2763129624989, 1041.9479026048666, 5811.593188476851, 5902.409759024149, 5923.585349025527, 5943.435373639497, 6027.095935609606, 1083.6099004358425, 1100.0309446091567, 1100.7688385438987, 1109.866815982071, 1118.59730497021, 3893.162969961472, 3993.8602148924647, 4114.362273847559, 4120.990357362405, 4126.628603425706, 9821.656242031495, 10124.443155626512, 10233.795324093626, 10242.48787560619, 10261.384316941007, 10060.74848128788, 10070.848937265946, 10146.746331341628, 10147.543360548792, 10167.898321016843, 7950.363970882316, 8068.112507624157, 8079.434439589172, 8085.191480851985, 8085.514869107872, 5522.944770552243, 5551.333839939233, 5598.468145526169, 5623.156526521055, 5692.1461780733225, 9095.135962083592, 9324.440533568008, 9358.906410935804, 9473.0, 9491.0, 9194.862077068983, 9543.90456095458, 9594.952025239829, 9663.565139568596, 9767.218622510325, 7827.882581761164, 7892.921070789448, 7919.247671471201, 7995.520268783892, 8001.319887809602, 8079.87880181786, 8146.389020823343, 8149.877751833608, 8150.144234855492, 8150.673973041012, 7236.819079523054, 7540.698372065056, 7577.621118944141, 7587.317141457295, 7624.428167887541, 7491.475596708397, 7516.962415187889, 7549.7357592483995, 7562.546247225184, 7604.8479030417975, 6475.028745688184, 6536.0, 6557.704903279268, 6560.27836937946, 6580.934190658224, 4955.430125535466, 4961.900761984668, 5030.748462576783, 5031.169856973705, 5210.088234559013, 4981.62637802159, 4983.07813054586, 5003.824866129668, 5005.949940500694, 5112.335396398445], "value": 4631.97330642934, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.4315523000643, 418.4267553451771, 421.4394854843059, 426.9615734583888, 430.70711915897215, 5401.513863752261, 5417.214503896942, 5426.15894536347, 5438.265834112399, 5451.155070963997, 5130.434782608696, 5262.289590905227, 5267.657602255851, 5275.419703832576, 5415.891682166364, 4221.24017676818, 4253.55337689542, 4330.415393921828, 4357.3899654048455, 4358.6730995175485, 4336.804843782037, 4341.869743907688, 4352.782360881959, 4364.127174565099, 4397.714148580348, 4274.935875961863, 4354.303311470166, 4374.825006999717, 4381.079973205615, 4388.67084968627, 4340.175366680352, 4341.413909122291, 4356.346548017823, 4367.388565600819, 4378.8029538670835, 3996.300647386725, 4003.11931375097, 4007.8196481158416, 4009.3985902114914, 4018.296798060357, 5179.119549676527, 5267.920981185247, 5273.947260527384, 5300.946990530084, 5307.469253074701, 5019.0, 5020.723860187688, 5031.949680503221, 5033.697978121288, 5050.898982020339, 5679.290088738908, 5683.715814209273, 5688.374278829326, 5691.260136182311, 5706.629069110494, 4285.700000999931, 4395.604395604379, 4430.335449682541, 4434.60088592025, 4448.154850578379, 5867.354590994987, 5880.382559831199, 5888.205092312526, 5895.911561326584, 5907.291125064977, 4542.454905411372, 4577.862664120082, 4584.633229341644, 4587.334836448763, 4591.517890621503, 4434.689571729948, 4595.908081838412, 4616.838410655678, 4624.329472226508, 4626.0979109073405, 4995.150824359867, 5004.199328107558, 5007.874803129951, 5017.89964200714, 5072.695638261716, 5650.124230744241, 5688.63023903445, 5706.600537962386, 5735.598508104476, 5737.655740655574, 1463.370750577262, 1475.7343678138038, 1524.4588171199287, 1526.770984352334, 1534.9539513814605, 1031.5306535526317, 1066.5627092892032, 1093.283899046126, 1104.4643347976225, 1107.5348353691309, 5340.332458442695, 5410.729463526808, 5421.322334708161, 5438.8912221755345, 5440.4287549807495, 5256.5269125778095, 5596.27248457706, 5598.216249725042, 5598.944010559923, 5687.630304030225, 5346.198070289488, 5357.303550538405, 5357.946420535744, 5364.31784107946, 5399.463351504771, 2934.3691106411798, 2936.515474946653, 2951.4764876031113, 2968.6289213848268, 2986.656534498517, 5528.170774383874, 5782.421757824184, 5806.564507661942, 5845.357010728816, 5846.035404158351, 5643.012472817322, 5668.9716551417805, 5681.857953551194, 5683.431656834367, 5729.8772169167905, 5744.253247077937, 5784.363719990798, 5808.738606762621, 5831.4168583141345, 5841.0, 5467.371252306036, 5767.5674324425, 5776.393478684846, 5778.94221057784, 5791.218185544897, 5699.5725320600295, 5702.173184888251, 5713.600047996601, 5716.971415143064, 5793.449622285876, 5866.530677545701, 6010.9699451502465, 6029.854327677727, 6063.818085457443, 6080.817575472743, 4257.765822879772, 4277.700560960703, 4308.0, 4308.935365969451, 4309.762963037063, 5838.912416313844, 5927.0, 5928.347881733092, 5946.226990491208, 5946.524278057832, 5475.233467314659, 5635.605507614428, 5674.914876276942, 5681.0, 5774.181132943109, 5647.05176714033, 5665.988574056316, 5668.37647858727, 5668.688222147822, 5669.461401166883, 5404.32445944257, 5479.561635069264, 5544.916826247529, 5609.635373700697, 5658.40586738403, 5607.897038610521, 5650.0, 5683.772649094155, 5690.772369105355, 5691.658500489983, 5483.550843527255, 5489.670619762827, 5560.972195138998, 5605.598600349913, 5606.6636001840025], "value": 4415.187196753473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.9061707903589, 819.7622689420068, 858.6779957515931, 914.8581969794682, 931.4876817750236, 16569.25438355274, 17553.73669394957, 18016.4595062148, 18046.72929906051, 18087.72868406975, 15294.464693735721, 15376.461823836167, 15419.537413877602, 15425.845741542582, 15456.22718864055, 710.2329484157124, 713.0730050933792, 806.4395245304515, 818.1327792539897, 837.5644664774313, 828.9336853051772, 837.9078301386843, 843.7047033538274, 844.501743971057, 845.4251109245711, 892.4511425473352, 893.3255392178896, 894.0, 894.2711689972684, 894.306912143091, 736.3078706016381, 742.5655991245128, 854.1543871567104, 877.2455688108222, 880.7930136417937, 639.1403562208822, 642.5662677692538, 643.1253495246461, 643.3373625166087, 643.6009674002102, 16776.161191940355, 16790.328386864512, 16822.411215607517, 16852.24164912582, 17324.22041008145, 15146.5456036318, 16043.919780401024, 16057.759133613004, 16251.187440627922, 16356.672866542722, 14200.715985680332, 14283.285835708173, 14288.714225715532, 14299.070560413644, 14325.498607548685, 4543.477500087499, 4579.22153233951, 4589.449266088058, 4604.102200070987, 4683.88290292742, 80752.0, 82375.17624823735, 83347.0, 84968.0, 85675.57162214149, 11798.941005294919, 11934.104942129376, 11985.28088314704, 12003.219790713576, 12185.0, 22631.094756209895, 22643.0, 22672.206472773374, 22796.772032279467, 22886.885565572065, 8335.249827515432, 8410.663573457115, 8411.0, 8431.873521897176, 8607.096254893271, 4575.702579332333, 4674.088552732184, 4684.0866031123605, 4735.857924262277, 4835.879103022453, 3637.181634132352, 3723.925521489555, 3728.422094575345, 3731.1418373774186, 3732.2162345907122, 622.3651875087476, 626.3173141276031, 628.230417738267, 639.7313128485954, 645.1773988165033, 809.223145780046, 818.3126174013738, 821.7165078048064, 829.8298848735994, 830.8552130187333, 10583.100436462833, 10672.573097076185, 10772.676819695422, 11035.503402346914, 11119.0, 746.7722344684923, 754.9886751698729, 772.3396495995955, 780.683823051665, 786.3551887452235, 4880.707157570557, 5497.120460726264, 5780.826575202751, 5869.148973398833, 5879.764809407661, 65134.34865651378, 68246.65876670585, 78022.60988695134, 78321.21678783139, 78846.60576697194, 49037.0, 58605.41394586085, 60244.69877650584, 61496.0, 62676.373236267056, 55887.44112558904, 56884.43115568791, 57268.0, 57804.0, 58496.0, 11122.777544449227, 11421.828672570084, 11561.901619346148, 11710.648680539598, 11764.35296058725, 40185.79907100446, 40592.1881562373, 40635.1872962545, 40701.0, 41568.376474353514, 47847.41144414113, 52060.47939520556, 52130.0, 52664.47335526596, 54962.0, 13561.593152205449, 13670.316484175553, 13783.51757688476, 13807.102538334975, 13989.090709103875, 15397.0, 15409.152496612794, 15680.843191568394, 15706.450274240347, 15937.0, 14502.202378868842, 14709.92645036768, 14795.260236988323, 14972.7005459888, 15041.774373384627, 14613.780793287897, 14842.554723358317, 14852.904574642667, 15178.468753593572, 15704.450344237897, 14564.660055249346, 14611.0, 14880.479183228535, 15159.545213643609, 15389.0, 11229.27009744364, 11327.490262938352, 11484.94257528707, 11735.002524785488, 11939.880601193878, 11441.370724610226, 11682.649520514398, 11958.10314226454, 11960.222585531912, 12014.939925300318], "value": 7637.834669679939, "unit": "score"}], "name": "dromaeo_css", "value": 7606.324332390197, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 121.0, 155.0, 120.0, 119.0, 118.0, 116.0, 137.0, 123.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 161.0, 162.0, 160.0, 161.0, 159.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 109.0, 76.0, 76.0, 84.0, 76.0, 98.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 117.0, 83.0, 83.0, 83.0, 100.0, 82.0, 82.0, 104.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 48.0, 48.0, 49.0, 49.0, 49.0, 50.0, 48.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 76.0, 76.0, 76.0, 75.0, 77.0, 75.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 120.0, 121.0, 126.0, 123.0, 126.0, 129.0, 163.0, 123.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 157.0, 162.0, 157.0, 158.0, 159.0, 156.0, 161.0, 164.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 64.0, 60.0, 60.0, 61.0, 60.0, 59.0, 61.0], "value": 61.0, "unit": "score"}], "name": "kraken", "value": 1468.3, "alertThreshold": 2.0}]} 16:01:48 INFO - Return code: 0 16:01:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:01:48 ERROR - # TBPL SUCCESS # 16:01:48 INFO - Running post-action listener: _resource_record_post_action 16:01:48 INFO - [mozharness: 2017-01-30 00:01:48.717015Z] Finished run-tests step (success) 16:01:48 INFO - Running post-run listener: _resource_record_post_run 16:01:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 274432; Write bytes: 374681600; Read time: 428; Write time: 269528 16:01:48 INFO - TinderboxPrint: CPU usage
13.0% 16:01:48 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 428 16:01:48 INFO - TinderboxPrint: I/O write bytes / time
374,681,600 / 269,528 16:01:48 INFO - TinderboxPrint: CPU idle
8,260.7 (87.0%) 16:01:48 INFO - TinderboxPrint: CPU user
1,191.0 (12.5%) 16:01:48 INFO - TinderboxPrint: Swap in / out
0 / 0 16:01:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 120684544; Read time: 204; Write time: 98708 16:01:48 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 270336; Write bytes: 253042688; Read time: 224; Write time: 170796 16:01:49 INFO - Running post-run listener: _upload_blobber_files 16:01:49 INFO - Blob upload gear active. 16:01:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:01:49 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 16:01:49 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:01:49 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:01:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:01:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:01:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:01:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:01:50 INFO - (blobuploader) - INFO - Done attempting. 16:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:01:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:01:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:01:51 INFO - (blobuploader) - INFO - Done attempting. 16:01:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:01:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:01:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:01:54 INFO - (blobuploader) - INFO - Done attempting. 16:01:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:01:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:01:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:01:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:01:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:01:55 INFO - (blobuploader) - INFO - Done attempting. 16:01:55 INFO - (blobuploader) - INFO - Iteration through files over. 16:01:55 INFO - Return code: 0 16:01:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:01:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:01:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/884f3471b9b2ef1f7e9ebd0a5a1fc07c8dece46cfbed0cacaec23da57511fc07228ceffbdf43f3f26090ab0407b31eb0b61b337ceebb874426f8442c27653c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c78275077e16e7cffa646c41a248571dfaa573471bbc1b18faaa938b4a9991ec0267ccfe2db339a6910da9a46c3d8fcd66012286f32d3dd0f1577cde834a11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd35032a1b41bcd78a19a85cc0d22bf0201c1c5eec65ece852e7ceae938dced05ab4287d9a6bfb51ac1ca9977020373a063c2fbd1f6c84a2345864cb557b61be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0ca48fa738fd8540fb2162c38ea8b9949afe7628cd2c34848a9ca2262ef495941dfd93a837c88936d067c2b1d158097fe2ff489b99cac0a4fd011eaf949c70"} 16:01:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:01:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:01:55 INFO - Contents: 16:01:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/884f3471b9b2ef1f7e9ebd0a5a1fc07c8dece46cfbed0cacaec23da57511fc07228ceffbdf43f3f26090ab0407b31eb0b61b337ceebb874426f8442c27653c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c78275077e16e7cffa646c41a248571dfaa573471bbc1b18faaa938b4a9991ec0267ccfe2db339a6910da9a46c3d8fcd66012286f32d3dd0f1577cde834a11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd35032a1b41bcd78a19a85cc0d22bf0201c1c5eec65ece852e7ceae938dced05ab4287d9a6bfb51ac1ca9977020373a063c2fbd1f6c84a2345864cb557b61be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0ca48fa738fd8540fb2162c38ea8b9949afe7628cd2c34848a9ca2262ef495941dfd93a837c88936d067c2b1d158097fe2ff489b99cac0a4fd011eaf949c70"} 16:01:55 INFO - Running post-run listener: copy_logs_to_upload_dir 16:01:55 INFO - Copying logs to upload dir... 16:01:55 INFO - mkdir: /builds/slave/test/build/upload/logs 16:01:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.054451 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-29 16:01:54.790715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 16:01:54.793957) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/884f3471b9b2ef1f7e9ebd0a5a1fc07c8dece46cfbed0cacaec23da57511fc07228ceffbdf43f3f26090ab0407b31eb0b61b337ceebb874426f8442c27653c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c78275077e16e7cffa646c41a248571dfaa573471bbc1b18faaa938b4a9991ec0267ccfe2db339a6910da9a46c3d8fcd66012286f32d3dd0f1577cde834a11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd35032a1b41bcd78a19a85cc0d22bf0201c1c5eec65ece852e7ceae938dced05ab4287d9a6bfb51ac1ca9977020373a063c2fbd1f6c84a2345864cb557b61be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0ca48fa738fd8540fb2162c38ea8b9949afe7628cd2c34848a9ca2262ef495941dfd93a837c88936d067c2b1d158097fe2ff489b99cac0a4fd011eaf949c70"} build_url:https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/Khp4t3AcS1aeFMcJLSxTxg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/884f3471b9b2ef1f7e9ebd0a5a1fc07c8dece46cfbed0cacaec23da57511fc07228ceffbdf43f3f26090ab0407b31eb0b61b337ceebb874426f8442c27653c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c78275077e16e7cffa646c41a248571dfaa573471bbc1b18faaa938b4a9991ec0267ccfe2db339a6910da9a46c3d8fcd66012286f32d3dd0f1577cde834a11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd35032a1b41bcd78a19a85cc0d22bf0201c1c5eec65ece852e7ceae938dced05ab4287d9a6bfb51ac1ca9977020373a063c2fbd1f6c84a2345864cb557b61be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0ca48fa738fd8540fb2162c38ea8b9949afe7628cd2c34848a9ca2262ef495941dfd93a837c88936d067c2b1d158097fe2ff489b99cac0a4fd011eaf949c70"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 16:01:54.818255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:01:54.818555) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1485732322.227786-862919790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:01:54.902331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 16:01:54.902644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 16:01:54.902915) ========= ========= Total master_lag: 0.16 =========