builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-081 starttime: 1491381623.03 results: success (0) revision: 896e9cfb9d67d6a73e70e39532f31306c22202cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.028279) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.028834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.029159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.044165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.044484) ========= 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=483e410453545d07cca6935c000001ab-1491381623.118500-1116890065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 01:40:23-- 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% 42.6M=0s 2017-04-05 01:40:23 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.192086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.192465) ========= 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=483e410453545d07cca6935c000001ab-1491381623.118500-1116890065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014126 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:23.244955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 01:40:23.245316) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 896e9cfb9d67d6a73e70e39532f31306c22202cb --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 896e9cfb9d67d6a73e70e39532f31306c22202cb --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=483e410453545d07cca6935c000001ab-1491381623.118500-1116890065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 01:40:24,015 truncating revision to first 12 chars 2017-04-05 01:40:24,016 Setting DEBUG logging. 2017-04-05 01:40:24,016 attempt 1/10 2017-04-05 01:40:24,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/896e9cfb9d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 01:40:25,291 unpacking tar archive at: mozilla-aurora-896e9cfb9d67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.604043 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 01:40:24.863304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:24.863704) ========= script_repo_revision: 896e9cfb9d67d6a73e70e39532f31306c22202cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:24.864194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:24.864511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 01:40:24.875140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-05 01:40:24.875458) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1491381623.118500-1116890065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:40:25 INFO - MultiFileLogger online at 20170405 01:40:25 in /builds/slave/test 01:40:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 01:40:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:40:25 INFO - {'append_to_log': False, 01:40:25 INFO - 'base_work_dir': '/builds/slave/test', 01:40:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:40:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:40:25 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:40:25 INFO - 'buildbot_json_path': 'buildprops.json', 01:40:25 INFO - 'config_files': ('talos/linux_config.py',), 01:40:25 INFO - 'default_actions': ('clobber', 01:40:25 INFO - 'read-buildbot-config', 01:40:25 INFO - 'download-and-extract', 01:40:25 INFO - 'populate-webroot', 01:40:25 INFO - 'create-virtualenv', 01:40:25 INFO - 'install', 01:40:25 INFO - 'run-tests'), 01:40:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:40:25 INFO - 'download_minidump_stackwalk': True, 01:40:25 INFO - 'download_symbols': 'ondemand', 01:40:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:40:25 INFO - 'tooltool.py': '/tools/tooltool.py', 01:40:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:40:25 INFO - '/tools/misc-python/virtualenv.py')}, 01:40:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:40:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:40:25 INFO - 'gecko_profile': False, 01:40:25 INFO - 'gecko_profile_interval': 0, 01:40:25 INFO - 'installer_path': 'installer.exe', 01:40:25 INFO - 'log_level': 'info', 01:40:25 INFO - 'log_name': 'talos', 01:40:25 INFO - 'log_to_console': True, 01:40:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:40:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:40:25 INFO - 'opt_config_files': (), 01:40:25 INFO - 'pip_index': False, 01:40:25 INFO - 'suite': 'dromaeojs-e10s', 01:40:25 INFO - 'system_bits': '32', 01:40:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:40:25 INFO - 'title': 'talos-linux64-ix-081', 01:40:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:40:25 INFO - 'use_talos_json': True, 01:40:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:40:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:40:25 INFO - 'work_dir': 'build'} 01:40:25 INFO - [mozharness: 2017-04-05 08:40:25.747717Z] Running clobber step. 01:40:25 INFO - Running pre-action listener: _resource_record_pre_action 01:40:25 INFO - Running main action method: clobber 01:40:25 INFO - rmtree: /builds/slave/test/build 01:40:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:40:26 INFO - Running post-action listener: _resource_record_post_action 01:40:26 INFO - [mozharness: 2017-04-05 08:40:26.729860Z] Finished clobber step (success) 01:40:26 INFO - [mozharness: 2017-04-05 08:40:26.729958Z] Running read-buildbot-config step. 01:40:26 INFO - Running pre-action listener: _resource_record_pre_action 01:40:26 INFO - Running main action method: read_buildbot_config 01:40:26 INFO - Using buildbot properties: 01:40:26 INFO - { 01:40:26 INFO - "project": "", 01:40:26 INFO - "product": "firefox", 01:40:26 INFO - "who": "nobody@mozilla.org", 01:40:26 INFO - "installer_path": "public/build/target.tar.bz2", 01:40:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 01:40:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:40:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 01:40:26 INFO - "stage_platform": "linux64", 01:40:26 INFO - "basedir": "/builds/slave/test", 01:40:26 INFO - "buildnumber": 111, 01:40:26 INFO - "platform": "ubuntu64_hw", 01:40:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:40:26 INFO - "slavebuilddir": "test", 01:40:26 INFO - "taskId": "ZAJ4B01pQ-a-8xCEERvnRQ", 01:40:26 INFO - "branch": "mozilla-aurora", 01:40:26 INFO - "script_repo_revision": "production", 01:40:26 INFO - "revision": "896e9cfb9d67d6a73e70e39532f31306c22202cb", 01:40:26 INFO - "slavename": "talos-linux64-ix-081", 01:40:26 INFO - "repo_path": "releases/mozilla-aurora" 01:40:26 INFO - } 01:40:26 INFO - Finding installer, test and symbols from parent task. 01:40:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAJ4B01pQ-a-8xCEERvnRQ'}, attempt #1 01:40:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAJ4B01pQ-a-8xCEERvnRQ'}, attempt #1 01:40:27 INFO - Task dependencies: H5W_OCrhRfOt9Dy5Q25ARg 01:40:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg'}, attempt #1 01:40:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2 01:40:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/test_packages.json 01:40:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.crashreporter-symbols.zip 01:40:28 INFO - Running post-action listener: _resource_record_post_action 01:40:28 INFO - [mozharness: 2017-04-05 08:40:28.069603Z] Finished read-buildbot-config step (success) 01:40:28 INFO - [mozharness: 2017-04-05 08:40:28.069821Z] Running download-and-extract step. 01:40:28 INFO - Running pre-action listener: _resource_record_pre_action 01:40:28 INFO - Running main action method: download_and_extract 01:40:28 INFO - mkdir: /builds/slave/test/build/tests 01:40:28 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')]} 01:40:28 INFO - trying https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.test_packages.json 01:40:28 INFO - Downloading https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:40:28 INFO - Downloaded 896 bytes. 01:40:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:40:28 INFO - Using the following test package requirements: 01:40:28 INFO - {u'common': [u'target.common.tests.zip'], 01:40:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:40:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:40:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:40:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:40:28 INFO - u'mozbase': [u'target.common.tests.zip'], 01:40:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:40:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:40:28 INFO - u'web-platform': [u'target.common.tests.zip', 01:40:28 INFO - u'target.web-platform.tests.zip'], 01:40:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:40:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:40:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.common.tests.zip 01:40:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:40:28 INFO - Fetch https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.common.tests.zip into memory 01:40:30 INFO - Expected file size: 59545280 01:40:30 INFO - Obtained file size: 59545280 01:40:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:40:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.common.tests.zip 01:40:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:40:40 INFO - Fetch https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.common.tests.zip into memory 01:40:41 INFO - Expected file size: 59545280 01:40:41 INFO - Obtained file size: 59545280 01:40:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.talos.tests.zip 01:40:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:40:52 INFO - Fetch https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.talos.tests.zip into memory 01:40:53 INFO - Expected file size: 14404438 01:40:53 INFO - Obtained file size: 14404438 01:40: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')]} 01:40:53 INFO - trying https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2 01:40:53 INFO - Downloading https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:40:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:40:54 INFO - Downloaded 66712446 bytes. 01:40:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2 01:40:54 INFO - mkdir: /builds/slave/test/properties 01:40:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:40:54 INFO - Writing to file /builds/slave/test/properties/build_url 01:40:54 INFO - Contents: 01:40:54 INFO - build_url:https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2 01:40:54 INFO - Running post-action listener: _resource_record_post_action 01:40:54 INFO - Running post-action listener: set_extra_try_arguments 01:40:54 INFO - [mozharness: 2017-04-05 08:40:54.501745Z] Finished download-and-extract step (success) 01:40:54 INFO - [mozharness: 2017-04-05 08:40:54.501841Z] Running populate-webroot step. 01:40:54 INFO - Running pre-action listener: _resource_record_pre_action 01:40:54 INFO - Running main action method: populate_webroot 01:40:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:40:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:40:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:40:54 INFO - '--tppagecycles', 01:40:54 INFO - '7'], 01:40:54 INFO - 'tests': ['tsvgm']}}, 01:40:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:40:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:40:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:40:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:40:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['damp', 'tps']}, 01:40:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'tests': ['damp', 'tps']}, 01:40:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['dromaeo_dom']}, 01:40:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:40:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['basic_compositor_video']}, 01:40:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:40:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['a11yr', 01:40:54 INFO - 'ts_paint', 01:40:54 INFO - 'tpaint', 01:40:54 INFO - 'sessionrestore', 01:40:54 INFO - 'sessionrestore_no_auto_restore', 01:40:54 INFO - 'tabpaint']}, 01:40:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tsvgx', 01:40:54 INFO - 'tsvgr_opacity', 01:40:54 INFO - 'tart', 01:40:54 INFO - 'tscrollx', 01:40:54 INFO - 'cart', 01:40:54 INFO - 'tsvg_static']}, 01:40:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:40:54 INFO - 'tsvgr_opacity', 01:40:54 INFO - 'tart', 01:40:54 INFO - 'tscrollx', 01:40:54 INFO - 'cart', 01:40:54 INFO - 'tsvg_static']}, 01:40:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s'], 01:40:54 INFO - 'tests': ['tp5o']}, 01:40:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:40:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--disable-e10s', 01:40:54 INFO - '--xperf_path', 01:40:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:54 INFO - 'tests': ['tp5n']}, 01:40:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:40:54 INFO - 'talos_options': ['--xperf_path', 01:40:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:54 INFO - 'tests': ['tp5n']}}, 01:40:54 INFO - 'talos.zip': {'path': '', 01:40:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:40:54 INFO - Running post-action listener: _resource_record_post_action 01:40:54 INFO - [mozharness: 2017-04-05 08:40:54.515010Z] Finished populate-webroot step (success) 01:40:54 INFO - [mozharness: 2017-04-05 08:40:54.515100Z] Running create-virtualenv step. 01:40:54 INFO - Running pre-action listener: _resource_record_pre_action 01:40:54 INFO - Running main action method: create_virtualenv 01:40:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:40:54 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 01:40:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:40:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:40:54 INFO - Using real prefix '/usr' 01:40:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:40:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:40:57 INFO - Installing pip.................done. 01:40:57 INFO - Return code: 0 01:40:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:40:57 INFO - Reading from file tmpfile_stdout 01:40:57 INFO - Output received: 01:40:57 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) 01:40:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:40: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')]} 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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')]} 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:40: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', 'pip>=1.5'] in /builds/slave/test/build 01:40: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 pip>=1.5 01:40:57 INFO - Using env: {'DISPLAY': ':0', 01:40:57 INFO - 'HOME': '/home/cltbld', 01:40:57 INFO - 'LANG': 'en_US.UTF-8', 01:40:57 INFO - 'LANGUAGE': 'en_US:en', 01:40:57 INFO - 'LOGNAME': 'cltbld', 01:40:57 INFO - 'MAIL': '/var/mail/cltbld', 01:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:57 INFO - 'MOZ_NO_REMOTE': '1', 01:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:57 INFO - 'NO_EM_RESTART': '1', 01:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:57 INFO - 'PWD': '/builds/slave/test', 01:40:57 INFO - 'SHELL': '/bin/bash', 01:40:57 INFO - 'SHLVL': '1', 01:40:57 INFO - 'TERM': 'linux', 01:40:57 INFO - 'TMOUT': '86400', 01:40:57 INFO - 'USER': 'cltbld', 01:40:57 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:57 INFO - '_': '/tools/buildbot/bin/python'} 01:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:57 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 01:40:57 INFO - Cleaning up... 01:40:57 INFO - Return code: 0 01:40:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:40: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')]} 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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')]} 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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', '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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:40: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:40: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 psutil>=3.1.1 01:40:57 INFO - Using env: {'DISPLAY': ':0', 01:40:57 INFO - 'HOME': '/home/cltbld', 01:40:57 INFO - 'LANG': 'en_US.UTF-8', 01:40:57 INFO - 'LANGUAGE': 'en_US:en', 01:40:57 INFO - 'LOGNAME': 'cltbld', 01:40:57 INFO - 'MAIL': '/var/mail/cltbld', 01:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:57 INFO - 'MOZ_NO_REMOTE': '1', 01:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:57 INFO - 'NO_EM_RESTART': '1', 01:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:57 INFO - 'PWD': '/builds/slave/test', 01:40:57 INFO - 'SHELL': '/bin/bash', 01:40:57 INFO - 'SHLVL': '1', 01:40:57 INFO - 'TERM': 'linux', 01:40:57 INFO - 'TMOUT': '86400', 01:40:57 INFO - 'USER': 'cltbld', 01:40:57 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:57 INFO - '_': '/tools/buildbot/bin/python'} 01:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:57 INFO - Downloading/unpacking psutil>=3.1.1 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:57 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 01:40:57 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 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:59 INFO - Installing collected packages: psutil 01:40:59 INFO - Running setup.py install for psutil 01:40:59 INFO - building 'psutil._psutil_linux' extension 01:40:59 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 01:41:00 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 01:41:00 INFO - building 'psutil._psutil_posix' extension 01:41:00 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 01:41:00 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 01:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:00 INFO - Successfully installed psutil 01:41:00 INFO - Cleaning up... 01:41:00 INFO - Return code: 0 01:41:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:41:00 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')]} 01:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:00 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')]} 01:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:00 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:00 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 01:41:00 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 01:41:00 INFO - Using env: {'DISPLAY': ':0', 01:41:00 INFO - 'HOME': '/home/cltbld', 01:41:00 INFO - 'LANG': 'en_US.UTF-8', 01:41:00 INFO - 'LANGUAGE': 'en_US:en', 01:41:00 INFO - 'LOGNAME': 'cltbld', 01:41:00 INFO - 'MAIL': '/var/mail/cltbld', 01:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:00 INFO - 'MOZ_NO_REMOTE': '1', 01:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:00 INFO - 'NO_EM_RESTART': '1', 01:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:00 INFO - 'PWD': '/builds/slave/test', 01:41:00 INFO - 'SHELL': '/bin/bash', 01:41:00 INFO - 'SHLVL': '1', 01:41:00 INFO - 'TERM': 'linux', 01:41:00 INFO - 'TMOUT': '86400', 01:41:00 INFO - 'USER': 'cltbld', 01:41:00 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:00 INFO - '_': '/tools/buildbot/bin/python'} 01:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:41:00 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 01:41:00 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 01:41:00 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 01:41:00 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 01:41:00 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 01:41:00 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 01:41:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:41:02 INFO - Installing collected packages: mozsystemmonitor 01:41:02 INFO - Running setup.py install for mozsystemmonitor 01:41:02 INFO - Successfully installed mozsystemmonitor 01:41:02 INFO - Cleaning up... 01:41:02 INFO - Return code: 0 01:41:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:41:02 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')]} 01:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:02 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')]} 01:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:02 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:02 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 01:41:02 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 01:41:02 INFO - Using env: {'DISPLAY': ':0', 01:41:02 INFO - 'HOME': '/home/cltbld', 01:41:02 INFO - 'LANG': 'en_US.UTF-8', 01:41:02 INFO - 'LANGUAGE': 'en_US:en', 01:41:02 INFO - 'LOGNAME': 'cltbld', 01:41:02 INFO - 'MAIL': '/var/mail/cltbld', 01:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:02 INFO - 'MOZ_NO_REMOTE': '1', 01:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:02 INFO - 'NO_EM_RESTART': '1', 01:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:02 INFO - 'PWD': '/builds/slave/test', 01:41:02 INFO - 'SHELL': '/bin/bash', 01:41:02 INFO - 'SHLVL': '1', 01:41:02 INFO - 'TERM': 'linux', 01:41:02 INFO - 'TMOUT': '86400', 01:41:02 INFO - 'USER': 'cltbld', 01:41:02 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:02 INFO - '_': '/tools/buildbot/bin/python'} 01:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:03 INFO - Downloading/unpacking jsonschema==2.5.1 01:41:03 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 01:41:03 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 01:41:03 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 01:41:03 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 01:41:03 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 01:41:03 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 01:41:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:41:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:41:05 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 01:41:05 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 01:41:05 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 01:41:05 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 01:41:05 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 01:41:05 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 01:41:05 INFO - Downloading functools32-3.2.3-2.tar.gz 01:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:41:05 INFO - warning: no files found matching '*.txt' 01:41:05 INFO - no previously-included directories found matching 'build' 01:41:05 INFO - no previously-included directories found matching 'dist' 01:41:05 INFO - no previously-included directories found matching '.git*' 01:41:05 INFO - Installing collected packages: jsonschema, functools32 01:41:05 INFO - Running setup.py install for functools32 01:41:05 INFO - warning: no files found matching '*.txt' 01:41:05 INFO - no previously-included directories found matching 'build' 01:41:05 INFO - no previously-included directories found matching 'dist' 01:41:05 INFO - no previously-included directories found matching '.git*' 01:41:05 INFO - Successfully installed jsonschema functools32 01:41:05 INFO - Cleaning up... 01:41:05 INFO - Return code: 0 01:41:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:41:05 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')]} 01:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:05 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')]} 01:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:05 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:05 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 01:41:05 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 01:41:05 INFO - Using env: {'DISPLAY': ':0', 01:41:05 INFO - 'HOME': '/home/cltbld', 01:41:05 INFO - 'LANG': 'en_US.UTF-8', 01:41:05 INFO - 'LANGUAGE': 'en_US:en', 01:41:05 INFO - 'LOGNAME': 'cltbld', 01:41:05 INFO - 'MAIL': '/var/mail/cltbld', 01:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:05 INFO - 'MOZ_NO_REMOTE': '1', 01:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:05 INFO - 'NO_EM_RESTART': '1', 01:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:05 INFO - 'PWD': '/builds/slave/test', 01:41:05 INFO - 'SHELL': '/bin/bash', 01:41:05 INFO - 'SHLVL': '1', 01:41:05 INFO - 'TERM': 'linux', 01:41:05 INFO - 'TMOUT': '86400', 01:41:05 INFO - 'USER': 'cltbld', 01:41:05 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:05 INFO - '_': '/tools/buildbot/bin/python'} 01:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:41:05 INFO - Cleaning up... 01:41:05 INFO - Return code: 0 01:41:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:41:05 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')]} 01:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:05 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')]} 01:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:05 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:05 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 01:41:05 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 01:41:05 INFO - Using env: {'DISPLAY': ':0', 01:41:05 INFO - 'HOME': '/home/cltbld', 01:41:05 INFO - 'LANG': 'en_US.UTF-8', 01:41:05 INFO - 'LANGUAGE': 'en_US:en', 01:41:05 INFO - 'LOGNAME': 'cltbld', 01:41:05 INFO - 'MAIL': '/var/mail/cltbld', 01:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:05 INFO - 'MOZ_NO_REMOTE': '1', 01:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:05 INFO - 'NO_EM_RESTART': '1', 01:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:05 INFO - 'PWD': '/builds/slave/test', 01:41:05 INFO - 'SHELL': '/bin/bash', 01:41:05 INFO - 'SHLVL': '1', 01:41:05 INFO - 'TERM': 'linux', 01:41:05 INFO - 'TMOUT': '86400', 01:41:05 INFO - 'USER': 'cltbld', 01:41:05 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:05 INFO - '_': '/tools/buildbot/bin/python'} 01:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:06 INFO - Downloading/unpacking blobuploader==1.2.4 01:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:06 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 01:41:06 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 01:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:08 INFO - Downloading blobuploader-1.2.4.tar.gz 01:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:41:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:41:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 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 01:41:08 INFO - Downloading docopt-0.6.1.tar.gz 01:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:41:08 INFO - Installing collected packages: blobuploader, requests, docopt 01:41:08 INFO - Running setup.py install for blobuploader 01:41:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:41:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:41:08 INFO - Running setup.py install for requests 01:41:09 INFO - Running setup.py install for docopt 01:41:09 INFO - Successfully installed blobuploader requests docopt 01:41:09 INFO - Cleaning up... 01:41:09 INFO - Return code: 0 01:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:09 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')]} 01:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 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')]} 01:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:09 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 01:41:09 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 01:41:09 INFO - Using env: {'DISPLAY': ':0', 01:41:09 INFO - 'HOME': '/home/cltbld', 01:41:09 INFO - 'LANG': 'en_US.UTF-8', 01:41:09 INFO - 'LANGUAGE': 'en_US:en', 01:41:09 INFO - 'LOGNAME': 'cltbld', 01:41:09 INFO - 'MAIL': '/var/mail/cltbld', 01:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:09 INFO - 'MOZ_NO_REMOTE': '1', 01:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:09 INFO - 'NO_EM_RESTART': '1', 01:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:09 INFO - 'PWD': '/builds/slave/test', 01:41:09 INFO - 'SHELL': '/bin/bash', 01:41:09 INFO - 'SHLVL': '1', 01:41:09 INFO - 'TERM': 'linux', 01:41:09 INFO - 'TMOUT': '86400', 01:41:09 INFO - 'USER': 'cltbld', 01:41:09 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:09 INFO - '_': '/tools/buildbot/bin/python'} 01:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:09 INFO - Running setup.py (path:/tmp/pip-GugxCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:09 INFO - Running setup.py (path:/tmp/pip-bMTddL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:09 INFO - Running setup.py (path:/tmp/pip-_XI9rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:09 INFO - Running setup.py (path:/tmp/pip-P_KWcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:09 INFO - Running setup.py (path:/tmp/pip-UoqLD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:10 INFO - Running setup.py (path:/tmp/pip-YGEods-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:10 INFO - Running setup.py (path:/tmp/pip-a4wy5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:10 INFO - Running setup.py (path:/tmp/pip-pIoP28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:10 INFO - Running setup.py (path:/tmp/pip-cJZtV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:10 INFO - Running setup.py (path:/tmp/pip-baSG0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:10 INFO - Running setup.py (path:/tmp/pip-5_GZi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:10 INFO - Running setup.py (path:/tmp/pip-l_iECO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:10 INFO - Running setup.py (path:/tmp/pip-6HHdT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:10 INFO - Running setup.py (path:/tmp/pip-GRFAuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:10 INFO - Running setup.py (path:/tmp/pip-LMKBso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:10 INFO - Running setup.py (path:/tmp/pip-xA1oHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:10 INFO - Running setup.py (path:/tmp/pip-BTSxV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:41:10 INFO - Running setup.py install for manifestparser 01:41:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Running setup.py install for mozcrash 01:41:11 INFO - Running setup.py install for mozdebug 01:41:11 INFO - Running setup.py install for mozdevice 01:41:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Running setup.py install for mozfile 01:41:11 INFO - Running setup.py install for mozhttpd 01:41:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Running setup.py install for mozinfo 01:41:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Running setup.py install for mozInstall 01:41:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Running setup.py install for mozleak 01:41:11 INFO - Running setup.py install for mozlog 01:41:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:41:11 INFO - Running setup.py install for moznetwork 01:41:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:41:12 INFO - Running setup.py install for mozprocess 01:41:12 INFO - Running setup.py install for mozprofile 01:41:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:41:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:41:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:41:12 INFO - Running setup.py install for mozrunner 01:41:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:41:12 INFO - Running setup.py install for mozscreenshot 01:41:12 INFO - Running setup.py install for moztest 01:41:12 INFO - Running setup.py install for mozversion 01:41:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:41:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:41:12 INFO - Cleaning up... 01:41:12 INFO - Return code: 0 01:41:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:12 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')]} 01:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:12 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')]} 01:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:12 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:12 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 01:41:12 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 01:41:12 INFO - Using env: {'DISPLAY': ':0', 01:41:12 INFO - 'HOME': '/home/cltbld', 01:41:12 INFO - 'LANG': 'en_US.UTF-8', 01:41:12 INFO - 'LANGUAGE': 'en_US:en', 01:41:12 INFO - 'LOGNAME': 'cltbld', 01:41:12 INFO - 'MAIL': '/var/mail/cltbld', 01:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:12 INFO - 'MOZ_NO_REMOTE': '1', 01:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:12 INFO - 'NO_EM_RESTART': '1', 01:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:12 INFO - 'PWD': '/builds/slave/test', 01:41:12 INFO - 'SHELL': '/bin/bash', 01:41:12 INFO - 'SHLVL': '1', 01:41:12 INFO - 'TERM': 'linux', 01:41:12 INFO - 'TMOUT': '86400', 01:41:12 INFO - 'USER': 'cltbld', 01:41:12 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:12 INFO - '_': '/tools/buildbot/bin/python'} 01:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:12 INFO - Running setup.py (path:/tmp/pip-jnzKxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:13 INFO - Running setup.py (path:/tmp/pip-SHXsc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:13 INFO - Running setup.py (path:/tmp/pip-JaQY0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:13 INFO - Running setup.py (path:/tmp/pip-lYInG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:13 INFO - Running setup.py (path:/tmp/pip-iLBwJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:13 INFO - Running setup.py (path:/tmp/pip-m58YNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:13 INFO - Running setup.py (path:/tmp/pip-zuJEVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:13 INFO - Running setup.py (path:/tmp/pip-IFKDeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:13 INFO - Running setup.py (path:/tmp/pip-gH77xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:13 INFO - Running setup.py (path:/tmp/pip-bVGREb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:13 INFO - Running setup.py (path:/tmp/pip-Tv9dc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:13 INFO - Running setup.py (path:/tmp/pip-HzAJDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:13 INFO - Running setup.py (path:/tmp/pip-qb8bk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:13 INFO - Running setup.py (path:/tmp/pip-Os9Ilf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:13 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)) 01:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:13 INFO - Running setup.py (path:/tmp/pip-7iAyRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:14 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)) 01:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:14 INFO - Running setup.py (path:/tmp/pip-GGoSiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:14 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)) 01:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:14 INFO - Running setup.py (path:/tmp/pip-YuNOlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:14 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)) 01:41:14 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)) 01:41:14 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)) 01:41:14 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)) 01:41:14 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)) 01:41:14 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)) 01:41:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:14 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 01:41:14 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 01:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:16 INFO - Downloading blessings-1.6.tar.gz 01:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:41:16 INFO - Installing collected packages: blessings 01:41:16 INFO - Running setup.py install for blessings 01:41:16 INFO - Successfully installed blessings 01:41:16 INFO - Cleaning up... 01:41:16 INFO - Return code: 0 01:41:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:16 INFO - Reading from file tmpfile_stdout 01:41:16 INFO - Current package versions: 01:41:16 INFO - argparse == 1.2.1 01:41:16 INFO - blessings == 1.6 01:41:16 INFO - blobuploader == 1.2.4 01:41:16 INFO - docopt == 0.6.1 01:41:16 INFO - functools32 == 3.2.3-2 01:41:16 INFO - jsonschema == 2.5.1 01:41:16 INFO - manifestparser == 1.1 01:41:16 INFO - mozInstall == 1.12 01:41:16 INFO - mozcrash == 1.0 01:41:16 INFO - mozdebug == 0.1 01:41:16 INFO - mozdevice == 0.49 01:41:16 INFO - mozfile == 1.2 01:41:16 INFO - mozhttpd == 0.7 01:41:16 INFO - mozinfo == 0.9 01:41:16 INFO - mozleak == 0.1 01:41:16 INFO - mozlog == 3.4 01:41:16 INFO - moznetwork == 0.27 01:41:16 INFO - mozprocess == 0.25 01:41:16 INFO - mozprofile == 0.28 01:41:16 INFO - mozrunner == 6.13 01:41:16 INFO - mozscreenshot == 0.1 01:41:16 INFO - mozsystemmonitor == 0.3 01:41:16 INFO - moztest == 0.8 01:41:16 INFO - mozversion == 1.4 01:41:16 INFO - psutil == 3.1.1 01:41:16 INFO - requests == 1.2.3 01:41:16 INFO - wsgiref == 0.1.2 01:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:16 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')]} 01:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:16 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')]} 01:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:16 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:16 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 01:41:16 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 01:41:16 INFO - Using env: {'DISPLAY': ':0', 01:41:16 INFO - 'HOME': '/home/cltbld', 01:41:16 INFO - 'LANG': 'en_US.UTF-8', 01:41:16 INFO - 'LANGUAGE': 'en_US:en', 01:41:16 INFO - 'LOGNAME': 'cltbld', 01:41:16 INFO - 'MAIL': '/var/mail/cltbld', 01:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:16 INFO - 'MOZ_NO_REMOTE': '1', 01:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:16 INFO - 'NO_EM_RESTART': '1', 01:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:16 INFO - 'PWD': '/builds/slave/test', 01:41:16 INFO - 'SHELL': '/bin/bash', 01:41:16 INFO - 'SHLVL': '1', 01:41:16 INFO - 'TERM': 'linux', 01:41:16 INFO - 'TMOUT': '86400', 01:41:16 INFO - 'USER': 'cltbld', 01:41:16 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:16 INFO - '_': '/tools/buildbot/bin/python'} 01:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 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)) 01:41:16 INFO - Cleaning up... 01:41:16 INFO - Return code: 0 01:41:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:41:16 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')]} 01:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:16 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')]} 01:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:16 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 0x27171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2810a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, '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': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', '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 01:41:16 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 01:41:16 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 01:41:16 INFO - Using env: {'DISPLAY': ':0', 01:41:16 INFO - 'HOME': '/home/cltbld', 01:41:16 INFO - 'LANG': 'en_US.UTF-8', 01:41:16 INFO - 'LANGUAGE': 'en_US:en', 01:41:16 INFO - 'LOGNAME': 'cltbld', 01:41:16 INFO - 'MAIL': '/var/mail/cltbld', 01:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:16 INFO - 'MOZ_NO_REMOTE': '1', 01:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:16 INFO - 'NO_EM_RESTART': '1', 01:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:16 INFO - 'PWD': '/builds/slave/test', 01:41:16 INFO - 'SHELL': '/bin/bash', 01:41:16 INFO - 'SHLVL': '1', 01:41:16 INFO - 'TERM': 'linux', 01:41:16 INFO - 'TMOUT': '86400', 01:41:16 INFO - 'USER': 'cltbld', 01:41:16 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:16 INFO - '_': '/tools/buildbot/bin/python'} 01:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:41:17 INFO - Cleaning up... 01:41:17 INFO - Return code: 0 01:41:17 INFO - Running post-action listener: _resource_record_post_action 01:41:17 INFO - Running post-action listener: _start_resource_monitoring 01:41:17 INFO - Starting resource monitoring. 01:41:17 INFO - [mozharness: 2017-04-05 08:41:17.181540Z] Finished create-virtualenv step (success) 01:41:17 INFO - [mozharness: 2017-04-05 08:41:17.182056Z] Running install step. 01:41:17 INFO - Running pre-action listener: _resource_record_pre_action 01:41:17 INFO - Running main action method: install 01:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:17 INFO - Reading from file tmpfile_stdout 01:41:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:41:17 INFO - Reading from file tmpfile_stdout 01:41:17 INFO - Output received: 01:41:17 INFO - Usage: mozinstall [options] installer 01:41:17 INFO - Options: 01:41:17 INFO - -h, --help show this help message and exit 01:41:17 INFO - -d DEST, --destination=DEST 01:41:17 INFO - Directory to install application into. [default: 01:41:17 INFO - "/builds/slave/test"] 01:41:17 INFO - --app=APP Application being installed. [default: firefox] 01:41:17 INFO - mkdir: /builds/slave/test/build/application 01:41:17 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'] 01:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:41:34 INFO - Reading from file tmpfile_stdout 01:41:34 INFO - Output received: 01:41:34 INFO - /builds/slave/test/build/application/firefox/firefox 01:41:34 INFO - Running post-action listener: _resource_record_post_action 01:41:34 INFO - [mozharness: 2017-04-05 08:41:34.042346Z] Finished install step (success) 01:41:34 INFO - [mozharness: 2017-04-05 08:41:34.042625Z] Running run-tests step. 01:41:34 INFO - Running pre-action listener: _resource_record_pre_action 01:41:34 INFO - Running main action method: run_tests 01:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:41:34 INFO - Python 2.7.3 01:41:34 INFO - Return code: 0 01:41:34 INFO - grabbing minidump binary from tooltool 01: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')]} 01:41:34 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 0x29b2290>, '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 0x29b2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b3040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:41:34 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 01:41:34 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 01:41:34 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 01:41:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:41:34 INFO - Return code: 0 01:41:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:41:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:41:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:41:34 INFO - ENV: RUST_BACKTRACE is now 1 01:41:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:41:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:41:34 INFO - Using env: {'DISPLAY': ':0', 01:41:34 INFO - 'HOME': '/home/cltbld', 01:41:34 INFO - 'LANG': 'en_US.UTF-8', 01:41:34 INFO - 'LANGUAGE': 'en_US:en', 01:41:34 INFO - 'LOGNAME': 'cltbld', 01:41:34 INFO - 'MAIL': '/var/mail/cltbld', 01:41:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:41:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:34 INFO - 'MOZ_NO_REMOTE': '1', 01:41:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:34 INFO - 'NO_EM_RESTART': '1', 01:41:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:34 INFO - 'PWD': '/builds/slave/test', 01:41:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:41:34 INFO - 'RUST_BACKTRACE': '1', 01:41:34 INFO - 'SHELL': '/bin/bash', 01:41:34 INFO - 'SHLVL': '1', 01:41:34 INFO - 'TERM': 'linux', 01:41:34 INFO - 'TMOUT': '86400', 01:41:34 INFO - 'USER': 'cltbld', 01:41:34 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1491381623.118500-1116890065', 01:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:34 INFO - '_': '/tools/buildbot/bin/python'} 01:41:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:41:34 INFO - mozversion application_buildid: 20170405074801 01:41:34 INFO - mozversion application_changeset: 896e9cfb9d67d6a73e70e39532f31306c22202cb 01:41:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:41:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:41:34 INFO - mozversion application_name: Firefox 01:41:34 INFO - mozversion application_remotingname: firefox-dev 01:41:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:41:34 INFO - mozversion application_vendor: Mozilla 01:41:34 INFO - mozversion application_version: 54.0a2 01:41:34 INFO - mozversion platform_buildid: 20170405074801 01:41:34 INFO - mozversion platform_changeset: 896e9cfb9d67d6a73e70e39532f31306c22202cb 01:41:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:41:34 INFO - mozversion platform_version: 54.0a2 01:41:34 INFO - using testdate: 1491381694 01:41:34 INFO - actual date: 1491381694 01:41:34 INFO - starting webserver on 'localhost:37656' 01:41:34 INFO - SUITE-START | Running 2 tests 01:41:34 INFO - TEST-START | dromaeo_css 01:41:34 INFO - operating with platform_type : linux_ 01:41:34 INFO - Initialising browser for dromaeo_css test... 01:41:34 INFO - TEST-INFO | started process 21857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRjDP0/profile http://localhost:37656/getInfo.html) 01:41:38 INFO - PROCESS | 21857 | __metrics Screen width/height:1600/1200 01:41:38 INFO - PROCESS | 21857 | colorDepth:24 01:41:38 INFO - PROCESS | 21857 | Browser inner width/height: 1024/697 01:41:38 INFO - PROCESS | 21857 | __metrics 01:41:39 ERROR - PROCESS | 21857 | 1491381699526 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6373:36 < canClose@browser.js:5234:12 < forceQuit@jar:file:///tmp/tmpbRjDP0/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpbRjDP0/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpbRjDP0/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpbRjDP0/profile/extensions/talos-powers@TalosPowersService.js:55:9 01:41:39 ERROR - PROCESS | 21857 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 01:41:40 INFO - TEST-INFO | 21857: exit 0 01:41:40 INFO - Browser initialized. 01:41:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:41:40 INFO - TEST-INFO | started process 21988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRjDP0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:52 INFO - PROCESS | 21988 | RSS: Main: 147173376 01:41:52 INFO - PROCESS | 21988 | 01:44:52 INFO - PROCESS | 21988 | Cycle 1(1): loaded http://localhost:37656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37656/tests/dromaeo/cssquery-ext.html) 01:44:53 INFO - PROCESS | 21988 | RSS: Main: 154791936 01:44:53 INFO - PROCESS | 21988 | 01:46:40 INFO - PROCESS | 21988 | ************************* 01:46:40 INFO - PROCESS | 21988 | A coding exception was thrown and uncaught in a Task. 01:46:40 INFO - PROCESS | 21988 | 01:46:40 ERROR - PROCESS | 21988 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:40 INFO - PROCESS | 21988 | Full stack: 01:46:40 INFO - PROCESS | 21988 | ************************* 01:46:40 INFO - PROCESS | 21988 | ************************* 01:46:40 INFO - PROCESS | 21988 | A coding exception was thrown and uncaught in a Task. 01:46:40 INFO - PROCESS | 21988 | 01:46:40 ERROR - PROCESS | 21988 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:40 INFO - PROCESS | 21988 | Full stack: 01:46:40 INFO - PROCESS | 21988 | ************************* 01:46:40 INFO - PROCESS | 21988 | ************************* 01:46:40 INFO - PROCESS | 21988 | A coding exception was thrown and uncaught in a Task. 01:46:40 INFO - PROCESS | 21988 | 01:46:40 ERROR - PROCESS | 21988 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:40 INFO - PROCESS | 21988 | Full stack: 01:46:40 INFO - PROCESS | 21988 | ************************* 01:46:40 INFO - PROCESS | 21988 | ************************* 01:46:40 INFO - PROCESS | 21988 | A coding exception was thrown and uncaught in a Task. 01:46:40 INFO - PROCESS | 21988 | 01:46:40 ERROR - PROCESS | 21988 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:40 INFO - PROCESS | 21988 | Full stack: 01:46:40 INFO - PROCESS | 21988 | ************************* 01:47:55 INFO - PROCESS | 21988 | Cycle 1(1): loaded http://localhost:37656/tests/dromaeo/cssquery-ext.html (next: http://localhost:37656/tests/dromaeo/cssquery-jquery.html) 01:47:56 INFO - PROCESS | 21988 | RSS: Main: 152203264 01:47:56 INFO - PROCESS | 21988 | 01:50:58 INFO - PROCESS | 21988 | Cycle 1(1): loaded http://localhost:37656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37656/tests/dromaeo/cssquery-mootools.html) 01:50:58 INFO - PROCESS | 21988 | RSS: Main: 153505792 01:50:58 INFO - PROCESS | 21988 | 01:54:00 INFO - PROCESS | 21988 | Cycle 1(1): loaded http://localhost:37656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37656/tests/dromaeo/cssquery-prototype.html) 01:54:01 INFO - PROCESS | 21988 | RSS: Main: 151638016 01:54:01 INFO - PROCESS | 21988 | 01:57:03 INFO - PROCESS | 21988 | Cycle 1(1): loaded http://localhost:37656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37656/tests/dromaeo/cssquery-yui.html) 01:57:04 INFO - PROCESS | 21988 | RSS: Main: 157274112 01:57:04 INFO - PROCESS | 21988 | 02:00:06 INFO - PROCESS | 21988 | Cycle 1(1): loaded http://localhost:37656/tests/dromaeo/cssquery-yui.html (next: http://localhost:37656/tests/dromaeo/cssquery-dojo.html) 02:00:07 INFO - PROCESS | 21988 | RSS: Main: 157495296 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | __start_tp_report 02:00:07 INFO - PROCESS | 21988 | _x_x_mozilla_page_load 02:00:07 INFO - PROCESS | 21988 | _x_x_mozilla_page_load_details 02:00:07 INFO - PROCESS | 21988 | |i|pagename|runs| 02:00:07 INFO - PROCESS | 21988 | |0;dojo.html;3447.9999999999995;3468.5317482139912;3472.496488009239;3493.056874643846;3493.301339732054;5804.738786754596;5847.473727364536;5865.149553314772;5872.17789509469;5894.410558944103;5826.621269617472;5887.264091988502;5924.822255332336;5936.109583562467;5942.554308426875;5195.454477279878;5256.684598924057;5308.362996440433;5317.9202311965155;5330.733463326837;5325.467453254682;5337.813176538822;5337.839864804062;5346;5379.8386048418415;5055.46917573655;5092.8472145835685;5341.252224688546;5342.358916929974;5343.278657381262;5169.638125331228;5200.947990520084;5212.713300768456;5222.268882356473;5245.055889939809;5183.974080129613;5278.287431196778;5281.445448227958;5282.947170528322;5323.22813192085;5648.54811615074;5804.564657650651;5814.883702325972;5899.911501327483;5900.940990590082;6134.099846298212;6136.8560844342055;6172.84567885802;6181.3509581493745;6219.440250377488;6364.395382438661;6365.172527571386;6370.745170193187;6371.139896114011;6395.42441180296;5845.620034697731;5928.614640048383;5930.229070220887;5932.703364831741;5934.228550288435;6118.235220597426;6122.26532816056;6236.314005459396;6252.124702541648;6275.654838983808;6127.267034130328;6127.601705889103;6144.446999770043;6151.876962460726;6170.352113028068;6197.349278325801;6233.688315584202;6250.249970003629;6254.530910181755;6263.937360626426;6017.06735456005;6028.969855150784;6165.475934545524;6166.969165154145;6239.438450539473;6311.242650881832;6317.084022816666;6324.71538780756;6325.9051114233325;6329.113924050636;4625.7687115644085;4637.095766325601;4642.65180111493;4712.858614241578;4821.855344339676;4271.060366719316;4282.464691913511;4308.3968244445805;4311.202427550913;4331.047169622678;5827.650340979555;5845.824625261164;6077.665728384981;6119.694015299217;6159.1069294951985;6315.905261421082;6366.936330636634;6376.489880809524;6384.553081284358;6384.6169229846355;6183.412575805291;6185.165002724574;6190.380961903774;6194.59735117225;6196.566240363221;5152.819651312261;5160.535551800356;5386.5152136307925;5393.379761327419;5428.592855535771;6523.8695226095215;6582.539222254492;6686.5653732507235;6705.899411508832;6717;6363.809085727436;6369.172007638977;6370.394812492806;6373.490120790233;6382.234131904015;6309.621422714468;6609.4712423007;6647.6676166192465;6685.364890335411;6710.698018589273;6069.939300606938;6094.878102437838;6108.633481991094;6114.2357205349335;6124.724387402489;6324.209473815773;6363.045543168561;6369.394907483782;6373.3945275198785;6385.042243663488;6110.083487476914;6168.25980882297;6176.907346389898;6186.1648677427975;6188.164597779242;5930.733117009831;5967.045272756338;6073.14975903365;6078.969605151946;6098.481629061579;6126.356732543019;6168;6170.290416601969;6172;6174.44430001302;5962;6152.846178845564;6232.688365581612;6255.874882502233;6256.874862502634;5849.824505264849;5939.554533409925;5995.400459953969;6011.278646562266;6026.969865150646 02:00:07 INFO - PROCESS | 21988 | |1;ext.html;759.6695437484694;823.3701218567795;846.9110743371948;912.320321360586;938.5494962418044;41911.37132943005;43687.563124368746;47735.52264477354;47744.52255477444;47960;44871;45017.77491112548;45086.54913450865;45112.77443612785;45304;9188.999999999984;9270.39742416744;10091.344062635904;10363.430011349374;10644.095251903598;10273.845892311621;10275.332103413291;10288.537015834268;10317.793644127112;10336.844947325759;10354.2234332425;10370.014848589371;10389.013043760831;10415.375077495337;10425.739356516073;10233.283670143093;10252.89747102527;10336.328138671;10349.9482502587;10352.534135963824;9991.250656200742;10041.899581004243;10077.294589378746;10079.49602519871;10108;36654.63345366539;36758.816205918796;36940;36983;37007.07482312937;4030.1738143680477;4093.89765255868;4163.521195062576;4165.812538435777;4185.518665353493;26398.868005660042;26431.867840660867;26915.32711682204;26915.865420672966;27332;4197.895052623679;4225.746455212697;4239.385289133089;4250.511191213019;4314.417553630251;224035.99999999837;226302;228829;230978;231202;46650;46916.76541617338;46956.29565556519;47160.76419617949;47294.76352618215;48678.75660621674;48721.269180962314;48818.26772598414;48838.75580622145;48965;15608.29762660683;15755;15757.212139392985;15766.369345226292;15822.920885395499;13537.661558461117;13593.388297526635;13640.863591364157;13685.726285474235;13718.38267277955;12696.17474864131;12795.232286062866;12813.551525696555;12870.935645321713;12961.935190323988;5508.98921893514;5574.526165275997;5618.91571626426;5732.197492351074;5735.684537350402;1000.6247657128577;1006.993006993007;1019.2101121630795;1033.214756784849;1039.2465462539599;27381;27664.77940921042;27945.16164515027;28407.57388639172;28600;1093.420487141816;1097.4457898761075;1106.607154460155;1114.894085061934;1128.2046157458972;14341.498047568493;14376.496822611158;14505.637359065897;14842.183679897493;14921.253937303092;319954;321759;322419;322908;324264;57774.4222557769;58536.707316463144;58554;58568.414315857146;58873;1492.6939977304626;1521.5283262188757;1546;1576.9763453548205;1581.6994770993704;26745.598816018166;26994.595081073407;27691.861540692167;27908;27940.441191175654;44461.11077778491;44465.777671111435;44490.55509444864;44503.55496444994;44678.3298250533;303218.48390757904;303733;304104;304231;304893;29467.410651786417;30198.547021794253;32248.35503289968;32547.511787322735;32749.836250818593;39298.60701393064;39416.21167576575;39492.80253598829;39928;40139.598604014755;30999.380012400077;31008.379832403676;31052.68947310498;31077.378452431276;31384.529232061082;31028.844855775576;31411.528827067155;31426.68573314329;31478.213044674067;31616.841915790275;34904;35259.82370088133;35268.118297042776;35281.47077793784;35662;29549.55675664824;29665.5550166752;29683.40633187281;30001.099967001024;30183.245418864703;24174.516509669356;24409.75590244075;24473.51052978966;24511.63232551549;24810.379740506633 02:00:07 INFO - PROCESS | 21988 | |2;jquery.html;446.5802145982774;453.7391000174898;457.39623696720344;465.13717054863247;476.4758765358105;19606.50983725406;21496.46258843528;22051.558968820613;22353.664695029587;22719.999999999978;20349;20921.895390523026;21834.890825545852;22442.663360049613;22469.101235950544;6480.578762380442;6591.077249185118;6684.197896252432;6993.440524758007;7301.817454563626;7332.7066917323245;7489.36340411063;7511.474196806225;7525.849483010336;7549.962250188769;7644.46488745788;7690.115636701767;7711.074671039483;7718.421118416113;7731.574763388039;7466.77599672008;7587.924120758805;7650.540967541965;7695.192004839495;7700.653470593837;7360.815979600553;7370.336669699753;7413.8517229655645;7471.7011319547155;7499.737509187153;24854.130105446402;24855.751442485704;25122.874385627954;25489.980400783945;25566.744332556624;3146.763992700534;3219.114743445548;3220.473220473225;3221.114193596756;3264.298175892171;15452.459163929208;15970.281337339848;16011.839881601269;16209.351625934949;16455.42406015784;2095.518030852897;2106;2134.0930104705594;2163.5240247145603;2172.1420039084474;114013.42993285063;117407;117973.41013294965;118948.40525797315;121336;17783.73324400135;18289.26842926268;18764.81235187658;18805.435836924913;18862.622747545247;31357.8432107838;31421.528677069862;31761.888333908202;31768.523472147936;31938.041858744276;10007.199424046059;10024.749381265381;10206.897931020743;10456.477176141314;10471.895281047244;8548.273396761346;8549.615267312862;8558.657653693783;8706.303495720327;8765.737027889174;8833.160849719266;8885.644574217089;9016.368854180144;9291.210247128934;9336.626534938663;3541.6281290464644;3688.2070354873294;3720.1257704439436;3874.8256328465286;3918.333883239799;960.9903900961041;967.1730670276953;977.4282045003611;977.9070988256104;979.1383582447543;19998.50003749918;20446.795532044787;20838.58322833565;21031.8948405257;21158.259460918795;979.4759803505233;981.1415011864618;985.4629227071264;987.8320685483485;1004.7337455574278;11160.720981975353;11455.83535664264;11668.591599293984;11670.766584668429;11711.414429278673;639066;648016;653051;654099;680954;114279;115251.42374288243;118858.4057079709;119137.40431297962;119646;1282.6665067082627;1291.4511332683571;1311.8622544632676;1313.835770528684;1316.8551459339465;17293.56766080858;17684.823151768316;18086.276548937894;18178.181981810587;18344.357947471774;47235;53274;53444.46555534395;54946.450535494136;55198.724006379714;63168;64061.35938640554;65030;73808.26191738014;76248;12519.812202816784;12982.675433114247;13031;13056.281904495345;13076.476940922257;14542.054766440147;14574.417023318949;14593.562193134223;14913.478028268959;14997.475088371855;12634.620961371174;12649.430775614936;12685.93657031709;12772.169808962388;12818.74362512726;11726.885945835133;11734.237274577124;11873.643790686294;11876.643700688648;12003.699907502383;12028.75942481128;12174.513019479476;13121.93439032837;13199.736005279648;13362.131461454974;12954.676133096747;13039.282839443922;13050.608481745563;13253.403596837972;13450.663733406353;12555.623331300076;12578.308193049104;12955.417006234553;12989.090763646454;13092.410841511964 02:00:07 INFO - PROCESS | 21988 | |3;mootools.html;1576.4955214331403;1583.0897234090398;1590.165163289273;1593.625498007968;1613.8224795272517;10047.899521004787;10334.7416314592;10925.672229833099;11669.008134308584;11686.649400517987;11217.887821121787;11613.361265130414;11620.767584648302;11623.360715160663;11623.65129046128;2512.937176570587;2550.744925507453;2567.422329975759;2567.9871600641973;2569.498947705198;2469.09877894569;2522.2055052658447;2531.3798119460666;2540.7078186008566;2541.1995221505167;2436.634504824273;2461.716902556202;2477.3930387055107;2512.1207577347964;2514.8491090534535;2349.8472599281076;2364.9645255321184;2376.9762302376926;2380.226426411406;2384.630382290739;2313.1788215183706;2370.573296806574;2376.0733314007553;2383.285014495644;2383.9523209535714;11757.118216133824;12008.099392545593;12152.696182595506;12158.270503769802;12165.391730413445;6024.759009639609;6161.44546990773;6175.197224360804;6186.319504854462;6195.1946246988055;3536.3104194682046;3609.3322735294055;3672.8714494992546;3676.227992121631;3679.8344074516444;1275.3431982529005;1283.2941881964975;1328.2229895511139;1350.5070649213064;1375.5185685010267;16893.746593801105;17626.383076592258;17754.289828406847;17985;18332.45002649936;4754.144254034238;4780.943025540275;4802.303665968485;4840.2255639098275;4876.707397556158;13108.279044652445;13131.60605181846;13294.268815215257;13300.667483312995;13358.198508089547;5915.964706176488;6000.159977603139;6015.248093988252;6033.396660333931;6041.184440100618;4544.522825103382;5428.131498960148;5559.138333558305;5569.415211402826;5590.301212348457;3948.743331683489;3994.8801535953967;4011.8997025074605;4079.2453396121814;4088.2232375848494;1034.886162522137;1037.4553359486179;1046.2257929132388;1051.3901936876593;1051.663467690347;1012.2205901455985;1040.9375437473775;1056.4612047855649;1061.0715623829149;1061.5753698520653;6653.301403352578;6733.797986060426;6771.085903403076;6794.626295553792;6883.483738719616;1005.9446730429751;1011.7369483934083;1034.2088302448633;1063.9734006649742;1084.5932775209296;4185.748855068706;4354.281543545279;4693.22561777303;4757.215059515211;4790.7365094920115;14947.1779052151;15633;15635.14006729618;15658;15664.765028524582;14398.568042958728;14927.477538286108;15573.454929077428;15784.21078946071;15794.131322777357;11025.44872756359;11203.327800332007;11208.383538905275;11252.774944501065;11253;7274.781756547312;7476.738314158978;7622.733204337822;7710.337345920114;7997.960010199912;13394.93302533481;13415.932920335335;13416.597502074954;13535.729285414434;13675.042747007614;13627.659308517366;13629.522966696119;13750.724985500434;13914.09558378702;13926.373313201133;9828.11546960777;9938;9959.751006224902;10064.798704026025;10077.244206684381;10971.561137554727;10980.286281391684;11109.388983605979;11249.66251012471;11322.547098115983;9188.770280743034;9419.717408477756;9529.237660987243;9557.569909354235;9961.501924903581;9546.18857397129;9578.233741300819;9644;9645.614175432904;9790.706278811647;8850.778730531789;8991.955040224757;9038.502882341534;9050.864237036318;9075.183233509017;6776;6782.186137663314;6825.419839313714;6835.077264569419;6895.310468953065;6783.423409010092;6804.523683342317;6827.829304267433;6857.382835544825;6986.16166060076 02:00:07 INFO - PROCESS | 21988 | |4;prototype.html;415.85029389419805;419.5301262585904;435.8104224662274;447.186121259308;448.5805771603551;5163.3545806774155;5256.632035757499;5360.5443537299325;5371.274877891484;5393.487618676224;5184.455632158616;5250.501202385777;5271.525562699366;5283.973580132104;5291.153415453528;4538.387317712108;4549.6360291176625;4555.772211389434;4558.61251793598;4576.359309696645;4419;4472.865814025585;4519.909601807962;4538.546145385468;4547.567981041796;4526.785981952818;4529.184746745585;4535.614472769818;4544.931826022612;4554.72671639701;4532.75628563863;4549.6360291176625;4558.407407037081;4574.359589657451;4577.9928415748645;4194.958050419487;4381.802818873159;4390.538993405678;4392.352867674622;4408.316710909814;5128.820371314581;5186.974065129651;5195.766190521435;5197.192596847938;5212.817551385721;5383.070358638177;5385.8114965976;5418.539424148952;5418.810341638024;5420;5338.505218538815;5564.527015203713;5577.191307260425;5604.411536788619;5669.518090962273;4896.36347274852;4903.670756390721;4924;4933.679310844819;4944.406671199443;5851.912221316641;5853.955942909705;5875.795461930294;5885.61743486672;5907.7464225757385;4510.345999830006;4776.8328108516735;4805.6155507559315;4814.518548145157;5152.330197074356;4851.762800485924;4852.708837469763;4862.32249873793;4873.586659868598;4880.463149053601;5098.311727916758;5184.585233181337;5190.532852043259;5192.61055420845;5197.896042079137;5470.753816078286;5478.287822583039;5557.472040156179;5568.8862227554655;5612.747426365823;1647.4728087012281;1672.8996260224426;1673.0547240808903;1675.0619652994362;1682.8064772551313;1251.2680082152042;1280.1359082619194;1290.5676598339662;1297.5199176304639;1310.4234136979699;5473.890522189534;5490.478404551562;5497;5514.007478653801;5514.779408823682;5623.834823592864;5644.9435505644415;5664.943350566442;5666.660000399989;5688.544916406678;5199.532042116228;5451.972740136274;5453.972730136324;5464;5501.019632932142;3005.2637103909246;3009.774266929945;3010.78924475289;3023.6069310989433;3033.4084853453805;5862.618929769551;5903.616264942765;5961.761529538857;5989.64062156272;6008.188894499274;5735.910177066344;5794.884102318014;5804.88390232193;5823.82528524145;5828.591998560145;5932.79235226765;5973.551983601247;5990;6006.609570377911;6011.849703757353;5374.838754837361;5613.438656134354;5679.801206957736;5699.774548472098;5713.342965559014;5467.835964921059;5537.723113844372;5585.357683866408;5649.858753531194;5659.688717120598;5769.480746732815;5907.645541267538;5938.061938061938;5984.551158663031;6035.69821508914;4759.976605029935;4778.068276686013;4787.736674482937;4794.2808578713475;4794.845541043462;5630.4369563043365;5768.2501274834;5786.652800831964;5795.478406943395;5854.970725146347;5583.246261754611;5596.440355964371;5628.549716022791;5646.265985421869;5654.46282603152;5533.667979921218;5619.831405057855;5621.8594535136945;5655.830325090089;5662.292213473316;5480.506754392124;5549.472800083986;5580.748866301107;5581.190727344593;5581.6371935824045;5640.971795140998;5642.238297829905;5687.1753595729215;5696.886062278649;5707.229524014371;5405.270288511158;5439.864003399946;5499.175123731312;5507.449255074461;5537.280153580009 02:00:07 INFO - PROCESS | 21988 | |5;yui.html;897.5287973813747;912.662314943471;915.9771005724856;918.6187732091182;948.6205517792885;14822.258887055645;15662.686746265068;15678.137702426377;15683.137427441487;15732.685346293081;16748.246328915197;16944.0680762558;16976.915115424435;17000.659986800256;17018;858.2361698088706;871.7210492642373;874.4185116897288;890.7773056735816;897.2642433204775;885.5306687455659;887.5739644970419;888.1296329596998;889.0265159650173;889.8442772514784;948.0519480519481;956.9186619137382;958.7411398922287;958.9089036541517;960.9903900961006;954.0411886054471;957.0190554681437;957.033396269769;957.3011701457905;958.4105774948426;698.7903628911306;699.3461113858508;700.0444393403019;702.0171759536638;702.3117345001875;16269.918650406791;16283.918580407022;16285.348586056543;16420.1789910504;16463.588410289718;15652.921735391365;16160.919195404065;16197.352105915748;16591.41930032443;16665;13145.277009764459;13498.797518037238;13729.794053089212;13825.446982120704;13887.166769993732;4045.4538637283886;4052.4529188559463;4054.1283624020684;4101.241270364992;4117.258893399187;63896;69606;75388.62305688491;80113.19886801115;81001.18998809996;12759.808602870964;13001;13131.146475479063;13244;13364.331783410791;23115.884420578124;23288.417789555057;23353.883230584077;23453.88273058624;23511.529769404515;8772.947246330481;8810.559472026373;8952.641894324153;8981.550922453851;9188.632454701738;4969.180085285887;5067.594592432597;5073.289739436482;5097.592192624581;5098.439171691111;3587.551556055493;3914.236723838824;4057.9797101014306;4141.52372477169;4147.149834283965;718.3175982816346;735.0481126940625;740.2190688823235;742.5210739073375;747.2228881962807;709.3119673916293;727.3889932456761;729.5950747335173;733.9559626422432;750.6171852355338;11493.252938558968;12027.338496382608;12053.156279060382;12471.625851224479;12477.688057798629;809.6356639512243;828.2173346187915;828.2338836576143;849.0914721248329;852.2244757270854;5645.774169033192;5669.121286200645;5701.2018317435595;5803.245578074823;5861.501772349398;69667.30332696608;84009.57995209986;85341.14658853332;86356;86972.56513717391;68424.65787671029;68557.65721171461;68987.31012689909;69106.308936911;70170.29829701739;53816.461835381146;55304;55804;58789;63416.36583634197;10969.067629251284;11369.2609980351;11388.886111138783;11585.6524304271;11651.12616553745;41489.792551037055;42387.78806106073;42615.7869210652;42990.78504607457;43189.13621727611;48641.37906898839;48895;49002.264966026254;49024;49388;13035.543755968496;13160.341982901009;13237.338133093499;13308.800367994294;13318.533851315546;16325.346986120423;16427;16729;16827.07451090153;17080.57298567546;15880.285387157375;15967.920160399124;16540.42108526244;16763.413280535122;16768.916155419145;15688.215589220721;15839.366425342858;15888.443904463289;16681.582960426087;16760.413385531447;15637.84362156364;15690.686186276438;16323.102229377499;16466.42367517131;16478.176091195633;11453.656390308304;11538.48076836561;11751.118666100248;11783.823242651195;11999.940000299943;12545.623631291075;12558.811617825922;12717.300548469922;12920.870791291967;12940.676483087622 02:00:07 INFO - PROCESS | 21988 | __end_tp_report 02:00:07 INFO - PROCESS | 21988 | __start_cc_report 02:00:07 INFO - PROCESS | 21988 | _x_x_mozilla_cycle_collect,326 02:00:07 INFO - PROCESS | 21988 | __end_cc_report 02:00:07 INFO - PROCESS | 21988 | __startTimestamp1491382807175__endTimestamp 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | ------- Summary: start ------- 02:00:07 INFO - PROCESS | 21988 | Number of tests: 6 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | [#0] dojo.html Cycles:165 Average:5827.30 Median:6098.48 stddev:678.25 (11.1%) stddev-sans-first:654.14 02:00:07 INFO - PROCESS | 21988 | Values: 3448.0 3468.5 3472.5 3493.1 3493.3 5804.7 5847.5 5865.1 5872.2 5894.4 5826.6 5887.3 5924.8 5936.1 5942.6 5195.5 5256.7 5308.4 5317.9 5330.7 5325.5 5337.8 5337.8 5346.0 5379.8 5055.5 5092.8 5341.3 5342.4 5343.3 5169.6 5200.9 5212.7 5222.3 5245.1 5184.0 5278.3 5281.4 5282.9 5323.2 5648.5 5804.6 5814.9 5899.9 5900.9 6134.1 6136.9 6172.8 6181.4 6219.4 6364.4 6365.2 6370.7 6371.1 6395.4 5845.6 5928.6 5930.2 5932.7 5934.2 6118.2 6122.3 6236.3 6252.1 6275.7 6127.3 6127.6 6144.4 6151.9 6170.4 6197.3 6233.7 6250.2 6254.5 6263.9 6017.1 6029.0 6165.5 6167.0 6239.4 6311.2 6317.1 6324.7 6325.9 6329.1 4625.8 4637.1 4642.7 4712.9 4821.9 4271.1 4282.5 4308.4 4311.2 4331.0 5827.7 5845.8 6077.7 6119.7 6159.1 6315.9 6366.9 6376.5 6384.6 6384.6 6183.4 6185.2 6190.4 6194.6 6196.6 5152.8 5160.5 5386.5 5393.4 5428.6 6523.9 6582.5 6686.6 6705.9 6717.0 6363.8 6369.2 6370.4 6373.5 6382.2 6309.6 6609.5 6647.7 6685.4 6710.7 6069.9 6094.9 6108.6 6114.2 6124.7 6324.2 6363.0 6369.4 6373.4 6385.0 6110.1 6168.3 6176.9 6186.2 6188.2 5930.7 5967.0 6073.1 6079.0 6098.5 6126.4 6168.0 6170.3 6172.0 6174.4 5962.0 6152.8 6232.7 6255.9 6256.9 5849.8 5939.6 5995.4 6011.3 6027.0 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | [#1] ext.html Cycles:180 Average:44800.61 Median:303918.50 stddev:75217.88 (24.7%) stddev-sans-first:75356.20 02:00:07 INFO - PROCESS | 21988 | Values: 759.7 823.4 846.9 912.3 938.5 41911.4 43687.6 47735.5 47744.5 47960.0 44871.0 45017.8 45086.5 45112.8 45304.0 9189.0 9270.4 10091.3 10363.4 10644.1 10273.8 10275.3 10288.5 10317.8 10336.8 10354.2 10370.0 10389.0 10415.4 10425.7 10233.3 10252.9 10336.3 10349.9 10352.5 9991.3 10041.9 10077.3 10079.5 10108.0 36654.6 36758.8 36940.0 36983.0 37007.1 4030.2 4093.9 4163.5 4165.8 4185.5 26398.9 26431.9 26915.3 26915.9 27332.0 4197.9 4225.7 4239.4 4250.5 4314.4 224036.0 226302.0 228829.0 230978.0 231202.0 46650.0 46916.8 46956.3 47160.8 47294.8 48678.8 48721.3 48818.3 48838.8 48965.0 15608.3 15755.0 15757.2 15766.4 15822.9 13537.7 13593.4 13640.9 13685.7 13718.4 12696.2 12795.2 12813.6 12870.9 12961.9 5509.0 5574.5 5618.9 5732.2 5735.7 1000.6 1007.0 1019.2 1033.2 1039.2 27381.0 27664.8 27945.2 28407.6 28600.0 1093.4 1097.4 1106.6 1114.9 1128.2 14341.5 14376.5 14505.6 14842.2 14921.3 319954.0 321759.0 322419.0 322908.0 324264.0 57774.4 58536.7 58554.0 58568.4 58873.0 1492.7 1521.5 1546.0 1577.0 1581.7 26745.6 26994.6 27691.9 27908.0 27940.4 44461.1 44465.8 44490.6 44503.6 44678.3 303218.5 303733.0 304104.0 304231.0 304893.0 29467.4 30198.5 32248.4 32547.5 32749.8 39298.6 39416.2 39492.8 39928.0 40139.6 30999.4 31008.4 31052.7 31077.4 31384.5 31028.8 31411.5 31426.7 31478.2 31616.8 34904.0 35259.8 35268.1 35281.5 35662.0 29549.6 29665.6 29683.4 30001.1 30183.2 24174.5 24409.8 24473.5 24511.6 24810.4 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | [#2] jquery.html Cycles:180 Average:37922.07 Median:21943.22 stddev:108124.65 (492.7%) stddev-sans-first:108391.36 02:00:07 INFO - PROCESS | 21988 | Values: 446.6 453.7 457.4 465.1 476.5 19606.5 21496.5 22051.6 22353.7 22720.0 20349.0 20921.9 21834.9 22442.7 22469.1 6480.6 6591.1 6684.2 6993.4 7301.8 7332.7 7489.4 7511.5 7525.8 7550.0 7644.5 7690.1 7711.1 7718.4 7731.6 7466.8 7587.9 7650.5 7695.2 7700.7 7360.8 7370.3 7413.9 7471.7 7499.7 24854.1 24855.8 25122.9 25490.0 25566.7 3146.8 3219.1 3220.5 3221.1 3264.3 15452.5 15970.3 16011.8 16209.4 16455.4 2095.5 2106.0 2134.1 2163.5 2172.1 114013.4 117407.0 117973.4 118948.4 121336.0 17783.7 18289.3 18764.8 18805.4 18862.6 31357.8 31421.5 31761.9 31768.5 31938.0 10007.2 10024.7 10206.9 10456.5 10471.9 8548.3 8549.6 8558.7 8706.3 8765.7 8833.2 8885.6 9016.4 9291.2 9336.6 3541.6 3688.2 3720.1 3874.8 3918.3 961.0 967.2 977.4 977.9 979.1 19998.5 20446.8 20838.6 21031.9 21158.3 979.5 981.1 985.5 987.8 1004.7 11160.7 11455.8 11668.6 11670.8 11711.4 639066.0 648016.0 653051.0 654099.0 680954.0 114279.0 115251.4 118858.4 119137.4 119646.0 1282.7 1291.5 1311.9 1313.8 1316.9 17293.6 17684.8 18086.3 18178.2 18344.4 47235.0 53274.0 53444.5 54946.5 55198.7 63168.0 64061.4 65030.0 73808.3 76248.0 12519.8 12982.7 13031.0 13056.3 13076.5 14542.1 14574.4 14593.6 14913.5 14997.5 12634.6 12649.4 12685.9 12772.2 12818.7 11726.9 11734.2 11873.6 11876.6 12003.7 12028.8 12174.5 13121.9 13199.7 13362.1 12954.7 13039.3 13050.6 13253.4 13450.7 12555.6 12578.3 12955.4 12989.1 13092.4 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | [#3] mootools.html Cycles:180 Average:7358.64 Median:2384.29 stddev:4754.35 (199.4%) stddev-sans-first:4747.83 02:00:07 INFO - PROCESS | 21988 | Values: 1576.5 1583.1 1590.2 1593.6 1613.8 10047.9 10334.7 10925.7 11669.0 11686.6 11217.9 11613.4 11620.8 11623.4 11623.7 2512.9 2550.7 2567.4 2568.0 2569.5 2469.1 2522.2 2531.4 2540.7 2541.2 2436.6 2461.7 2477.4 2512.1 2514.8 2349.8 2365.0 2377.0 2380.2 2384.6 2313.2 2370.6 2376.1 2383.3 2384.0 11757.1 12008.1 12152.7 12158.3 12165.4 6024.8 6161.4 6175.2 6186.3 6195.2 3536.3 3609.3 3672.9 3676.2 3679.8 1275.3 1283.3 1328.2 1350.5 1375.5 16893.7 17626.4 17754.3 17985.0 18332.5 4754.1 4780.9 4802.3 4840.2 4876.7 13108.3 13131.6 13294.3 13300.7 13358.2 5916.0 6000.2 6015.2 6033.4 6041.2 4544.5 5428.1 5559.1 5569.4 5590.3 3948.7 3994.9 4011.9 4079.2 4088.2 1034.9 1037.5 1046.2 1051.4 1051.7 1012.2 1040.9 1056.5 1061.1 1061.6 6653.3 6733.8 6771.1 6794.6 6883.5 1005.9 1011.7 1034.2 1064.0 1084.6 4185.7 4354.3 4693.2 4757.2 4790.7 14947.2 15633.0 15635.1 15658.0 15664.8 14398.6 14927.5 15573.5 15784.2 15794.1 11025.4 11203.3 11208.4 11252.8 11253.0 7274.8 7476.7 7622.7 7710.3 7998.0 13394.9 13415.9 13416.6 13535.7 13675.0 13627.7 13629.5 13750.7 13914.1 13926.4 9828.1 9938.0 9959.8 10064.8 10077.2 10971.6 10980.3 11109.4 11249.7 11322.5 9188.8 9419.7 9529.2 9557.6 9961.5 9546.2 9578.2 9644.0 9645.6 9790.7 8850.8 8992.0 9038.5 9050.9 9075.2 6776.0 6782.2 6825.4 6835.1 6895.3 6783.4 6804.5 6827.8 6857.4 6986.2 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | [#4] prototype.html Cycles:180 Average:4908.80 Median:5411.90 stddev:1293.63 (23.9%) stddev-sans-first:1252.53 02:00:07 INFO - PROCESS | 21988 | Values: 415.9 419.5 435.8 447.2 448.6 5163.4 5256.6 5360.5 5371.3 5393.5 5184.5 5250.5 5271.5 5284.0 5291.2 4538.4 4549.6 4555.8 4558.6 4576.4 4419.0 4472.9 4519.9 4538.5 4547.6 4526.8 4529.2 4535.6 4544.9 4554.7 4532.8 4549.6 4558.4 4574.4 4578.0 4195.0 4381.8 4390.5 4392.4 4408.3 5128.8 5187.0 5195.8 5197.2 5212.8 5383.1 5385.8 5418.5 5418.8 5420.0 5338.5 5564.5 5577.2 5604.4 5669.5 4896.4 4903.7 4924.0 4933.7 4944.4 5851.9 5854.0 5875.8 5885.6 5907.7 4510.3 4776.8 4805.6 4814.5 5152.3 4851.8 4852.7 4862.3 4873.6 4880.5 5098.3 5184.6 5190.5 5192.6 5197.9 5470.8 5478.3 5557.5 5568.9 5612.7 1647.5 1672.9 1673.1 1675.1 1682.8 1251.3 1280.1 1290.6 1297.5 1310.4 5473.9 5490.5 5497.0 5514.0 5514.8 5623.8 5644.9 5664.9 5666.7 5688.5 5199.5 5452.0 5454.0 5464.0 5501.0 3005.3 3009.8 3010.8 3023.6 3033.4 5862.6 5903.6 5961.8 5989.6 6008.2 5735.9 5794.9 5804.9 5823.8 5828.6 5932.8 5973.6 5990.0 6006.6 6011.8 5374.8 5613.4 5679.8 5699.8 5713.3 5467.8 5537.7 5585.4 5649.9 5659.7 5769.5 5907.6 5938.1 5984.6 6035.7 4760.0 4778.1 4787.7 4794.3 4794.8 5630.4 5768.3 5786.7 5795.5 5855.0 5583.2 5596.4 5628.5 5646.3 5654.5 5533.7 5619.8 5621.9 5655.8 5662.3 5480.5 5549.5 5580.7 5581.2 5581.6 5641.0 5642.2 5687.2 5696.9 5707.2 5405.3 5439.9 5499.2 5507.4 5537.3 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - PROCESS | 21988 | [#5] yui.html Cycles:180 Average:18096.40 Median:41938.79 stddev:21673.55 (51.7%) stddev-sans-first:21695.87 02:00:07 INFO - PROCESS | 21988 | Values: 897.5 912.7 916.0 918.6 948.6 14822.3 15662.7 15678.1 15683.1 15732.7 16748.2 16944.1 16976.9 17000.7 17018.0 858.2 871.7 874.4 890.8 897.3 885.5 887.6 888.1 889.0 889.8 948.1 956.9 958.7 958.9 961.0 954.0 957.0 957.0 957.3 958.4 698.8 699.3 700.0 702.0 702.3 16269.9 16283.9 16285.3 16420.2 16463.6 15652.9 16160.9 16197.4 16591.4 16665.0 13145.3 13498.8 13729.8 13825.4 13887.2 4045.5 4052.5 4054.1 4101.2 4117.3 63896.0 69606.0 75388.6 80113.2 81001.2 12759.8 13001.0 13131.1 13244.0 13364.3 23115.9 23288.4 23353.9 23453.9 23511.5 8772.9 8810.6 8952.6 8981.6 9188.6 4969.2 5067.6 5073.3 5097.6 5098.4 3587.6 3914.2 4058.0 4141.5 4147.1 718.3 735.0 740.2 742.5 747.2 709.3 727.4 729.6 734.0 750.6 11493.3 12027.3 12053.2 12471.6 12477.7 809.6 828.2 828.2 849.1 852.2 5645.8 5669.1 5701.2 5803.2 5861.5 69667.3 84009.6 85341.1 86356.0 86972.6 68424.7 68557.7 68987.3 69106.3 70170.3 53816.5 55304.0 55804.0 58789.0 63416.4 10969.1 11369.3 11388.9 11585.7 11651.1 41489.8 42387.8 42615.8 42990.8 43189.1 48641.4 48895.0 49002.3 49024.0 49388.0 13035.5 13160.3 13237.3 13308.8 13318.5 16325.3 16427.0 16729.0 16827.1 17080.6 15880.3 15967.9 16540.4 16763.4 16768.9 15688.2 15839.4 15888.4 16681.6 16760.4 15637.8 15690.7 16323.1 16466.4 16478.2 11453.7 11538.5 11751.1 11783.8 11999.9 12545.6 12558.8 12717.3 12920.9 12940.7 02:00:07 INFO - PROCESS | 21988 | -------- Summary: end -------- 02:00:07 INFO - PROCESS | 21988 | 02:00:07 INFO - TEST-INFO | 21988: exit 0 02:00:08 INFO - TEST-OK | dromaeo_css | took 1113663ms 02:00:08 INFO - TEST-START | kraken 02:00:08 INFO - operating with platform_type : linux_ 02:00:08 INFO - Initialising browser for kraken test... 02:00:08 INFO - TEST-INFO | started process 22364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUT_hsJ/profile http://localhost:37656/getInfo.html) 02:00:12 INFO - PROCESS | 22364 | __metrics Screen width/height:1600/1200 02:00:12 INFO - PROCESS | 22364 | colorDepth:24 02:00:12 INFO - PROCESS | 22364 | Browser inner width/height: 1024/697 02:00:12 INFO - PROCESS | 22364 | __metrics 02:00:13 ERROR - PROCESS | 22364 | 1491382813144 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6373:36 < canClose@browser.js:5234:12 < forceQuit@jar:file:///tmp/tmpUT_hsJ/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpUT_hsJ/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpUT_hsJ/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpUT_hsJ/profile/extensions/talos-powers@TalosPowersService.js:55:9 02:00:13 ERROR - PROCESS | 22364 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:00:14 INFO - TEST-INFO | 22364: exit 0 02:00:14 INFO - Browser initialized. 02:00:14 INFO - Running cycle 1/1 for kraken test... 02:00:14 INFO - TEST-INFO | started process 22499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUT_hsJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:25 INFO - PROCESS | 22499 | RSS: Main: 146944000 02:00:25 INFO - PROCESS | 22499 | 02:00:28 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37656/tests/kraken/driver.html?testName=audio-beat-detection) 02:00:29 INFO - PROCESS | 22499 | RSS: Main: 153845760 02:00:29 INFO - PROCESS | 22499 | 02:00:32 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37656/tests/kraken/driver.html?testName=audio-dft) 02:00:32 INFO - PROCESS | 22499 | RSS: Main: 152330240 02:00:32 INFO - PROCESS | 22499 | 02:00:35 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37656/tests/kraken/driver.html?testName=audio-fft) 02:00:36 INFO - PROCESS | 22499 | RSS: Main: 152621056 02:00:36 INFO - PROCESS | 22499 | 02:00:38 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37656/tests/kraken/driver.html?testName=audio-oscillator) 02:00:38 INFO - PROCESS | 22499 | RSS: Main: 152416256 02:00:38 INFO - PROCESS | 22499 | 02:00:40 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:00:41 INFO - PROCESS | 22499 | RSS: Main: 152248320 02:00:41 INFO - PROCESS | 22499 | 02:00:44 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37656/tests/kraken/driver.html?testName=imaging-darkroom) 02:00:45 INFO - PROCESS | 22499 | RSS: Main: 155480064 02:00:45 INFO - PROCESS | 22499 | 02:00:48 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37656/tests/kraken/driver.html?testName=imaging-desaturate) 02:00:49 INFO - PROCESS | 22499 | RSS: Main: 155455488 02:00:49 INFO - PROCESS | 22499 | 02:00:52 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37656/tests/kraken/driver.html?testName=json-parse-financial) 02:00:52 INFO - PROCESS | 22499 | RSS: Main: 154624000 02:00:52 INFO - PROCESS | 22499 | 02:00:54 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:00:54 INFO - PROCESS | 22499 | RSS: Main: 154697728 02:00:54 INFO - PROCESS | 22499 | 02:00:56 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:00:57 INFO - PROCESS | 22499 | RSS: Main: 154689536 02:00:57 INFO - PROCESS | 22499 | 02:00:59 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:01:00 INFO - PROCESS | 22499 | RSS: Main: 154841088 02:01:00 INFO - PROCESS | 22499 | 02:01:02 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:01:03 INFO - PROCESS | 22499 | RSS: Main: 154968064 02:01:03 INFO - PROCESS | 22499 | 02:01:06 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:01:06 INFO - PROCESS | 22499 | RSS: Main: 155283456 02:01:06 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | Cycle 1(1): loaded http://localhost:37656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37656/tests/kraken/driver.html?testName=ai-astar) 02:01:08 INFO - PROCESS | 22499 | RSS: Main: 157552640 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | __start_tp_report 02:01:08 INFO - PROCESS | 22499 | _x_x_mozilla_page_load 02:01:08 INFO - PROCESS | 22499 | _x_x_mozilla_page_load_details 02:01:08 INFO - PROCESS | 22499 | |i|pagename|runs| 02:01:08 INFO - PROCESS | 22499 | |0;ai-astar;105;114;116;112;114;113;118;113;113;119 02:01:08 INFO - PROCESS | 22499 | |1;audio-beat-detection;145;120;120;161;119;117;117;116;140;116 02:01:08 INFO - PROCESS | 22499 | |2;audio-dft;164;163;167;161;163;163;164;163;164;162 02:01:08 INFO - PROCESS | 22499 | |3;audio-fft;74;76;76;112;76;78;77;79;101;76 02:01:08 INFO - PROCESS | 22499 | |4;audio-oscillator;87;85;111;84;83;83;96;83;82;115 02:01:08 INFO - PROCESS | 22499 | |5;imaging-gaussian-blur;114;113;114;113;114;114;113;115;113;118 02:01:08 INFO - PROCESS | 22499 | |6;imaging-darkroom;148;148;148;148;148;148;148;147;147;148 02:01:08 INFO - PROCESS | 22499 | |7;imaging-desaturate;95;97;95;94;94;95;95;95;95;95 02:01:08 INFO - PROCESS | 22499 | |8;json-parse-financial;63;59;60;58;59;60;60;60;60;60 02:01:08 INFO - PROCESS | 22499 | |9;json-stringify-tinderbox;53;53;54;53;53;53;53;53;54;53 02:01:08 INFO - PROCESS | 22499 | |10;stanford-crypto-aes;77;81;80;80;77;86;84;77;79;76 02:01:08 INFO - PROCESS | 22499 | |11;stanford-crypto-ccm;125;133;138;132;122;132;123;129;167;138 02:01:08 INFO - PROCESS | 22499 | |12;stanford-crypto-pbkdf2;164;165;159;164;160;159;158;165;164;163 02:01:08 INFO - PROCESS | 22499 | |13;stanford-crypto-sha256-iterative;63;64;65;61;69;64;63;63;60;62 02:01:08 INFO - PROCESS | 22499 | __end_tp_report 02:01:08 INFO - PROCESS | 22499 | __start_cc_report 02:01:08 INFO - PROCESS | 22499 | _x_x_mozilla_cycle_collect,807 02:01:08 INFO - PROCESS | 22499 | __end_cc_report 02:01:08 INFO - PROCESS | 22499 | __startTimestamp1491382868721__endTimestamp 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | ------- Summary: start ------- 02:01:08 INFO - PROCESS | 22499 | Number of tests: 14 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:3.83 (3.4%) stddev-sans-first:2.45 02:01:08 INFO - PROCESS | 22499 | Values: 105.0 114.0 116.0 112.0 114.0 113.0 118.0 113.0 113.0 119.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:120.00 stddev:15.82 (13.2%) stddev-sans-first:15.40 02:01:08 INFO - PROCESS | 22499 | Values: 145.0 120.0 120.0 161.0 119.0 117.0 117.0 116.0 140.0 116.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.58 (1.0%) stddev-sans-first:1.66 02:01:08 INFO - PROCESS | 22499 | Values: 164.0 163.0 167.0 161.0 163.0 163.0 164.0 163.0 164.0 162.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:12.98 (17.1%) stddev-sans-first:13.40 02:01:08 INFO - PROCESS | 22499 | Values: 74.0 76.0 76.0 112.0 76.0 78.0 77.0 79.0 101.0 76.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.50 stddev:12.36 (14.8%) stddev-sans-first:13.03 02:01:08 INFO - PROCESS | 22499 | Values: 87.0 85.0 111.0 84.0 83.0 83.0 96.0 83.0 82.0 115.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 02:01:08 INFO - PROCESS | 22499 | Values: 114.0 113.0 114.0 113.0 114.0 114.0 113.0 115.0 113.0 118.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:01:08 INFO - PROCESS | 22499 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 148.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 02:01:08 INFO - PROCESS | 22499 | Values: 95.0 97.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:1.29 (2.1%) stddev-sans-first:0.73 02:01:08 INFO - PROCESS | 22499 | Values: 63.0 59.0 60.0 58.0 59.0 60.0 60.0 60.0 60.0 60.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#9] json-stringify-tinderbox Cycles:10 Average:53.20 Median:53.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 02:01:08 INFO - PROCESS | 22499 | Values: 53.0 53.0 54.0 53.0 53.0 53.0 53.0 53.0 54.0 53.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:3.27 (4.1%) stddev-sans-first:3.32 02:01:08 INFO - PROCESS | 22499 | Values: 77.0 81.0 80.0 80.0 77.0 86.0 84.0 77.0 79.0 76.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:132.50 stddev:12.91 (9.7%) stddev-sans-first:13.29 02:01:08 INFO - PROCESS | 22499 | Values: 125.0 133.0 138.0 132.0 122.0 132.0 123.0 129.0 167.0 138.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:164.00 stddev:2.77 (1.7%) stddev-sans-first:2.85 02:01:08 INFO - PROCESS | 22499 | Values: 164.0 165.0 159.0 164.0 160.0 159.0 158.0 165.0 164.0 163.0 02:01:08 INFO - PROCESS | 22499 | 02:01:08 INFO - PROCESS | 22499 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:2.46 (3.9%) stddev-sans-first:2.60 02:01:08 INFO - PROCESS | 22499 | Values: 63.0 64.0 65.0 61.0 69.0 64.0 63.0 63.0 60.0 62.0 02:01:08 INFO - PROCESS | 22499 | -------- Summary: end -------- 02:01:08 INFO - PROCESS | 22499 | 02:01:09 INFO - TEST-INFO | 22499: exit 0 02:01:09 INFO - TEST-OK | kraken | took 61745ms 02:01:09 INFO - SUITE-END | took 1175s 02:01:09 INFO - Completed test suite (00:19:35) 02:01:09 INFO - javascript benchmark 02:01:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7927.597293909419, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3447.9999999999995, 3468.5317482139912, 3472.496488009239, 3493.056874643846, 3493.301339732054, 5804.738786754596, 5847.473727364536, 5865.149553314772, 5872.17789509469, 5894.410558944103, 5826.621269617472, 5887.264091988502, 5924.822255332336, 5936.109583562467, 5942.554308426875, 5195.454477279878, 5256.684598924057, 5308.362996440433, 5317.9202311965155, 5330.733463326837, 5325.467453254682, 5337.813176538822, 5337.839864804062, 5346.0, 5379.8386048418415, 5055.46917573655, 5092.8472145835685, 5341.252224688546, 5342.358916929974, 5343.278657381262, 5169.638125331228, 5200.947990520084, 5212.713300768456, 5222.268882356473, 5245.055889939809, 5183.974080129613, 5278.287431196778, 5281.445448227958, 5282.947170528322, 5323.22813192085, 5648.54811615074, 5804.564657650651, 5814.883702325972, 5899.911501327483, 5900.940990590082, 6134.099846298212, 6136.8560844342055, 6172.84567885802, 6181.3509581493745, 6219.440250377488, 6364.395382438661, 6365.172527571386, 6370.745170193187, 6371.139896114011, 6395.42441180296, 5845.620034697731, 5928.614640048383, 5930.229070220887, 5932.703364831741, 5934.228550288435, 6118.235220597426, 6122.26532816056, 6236.314005459396, 6252.124702541648, 6275.654838983808, 6127.267034130328, 6127.601705889103, 6144.446999770043, 6151.876962460726, 6170.352113028068, 6197.349278325801, 6233.688315584202, 6250.249970003629, 6254.530910181755, 6263.937360626426, 6017.06735456005, 6028.969855150784, 6165.475934545524, 6166.969165154145, 6239.438450539473, 6311.242650881832, 6317.084022816666, 6324.71538780756, 6325.9051114233325, 6329.113924050636, 4625.7687115644085, 4637.095766325601, 4642.65180111493, 4712.858614241578, 4821.855344339676, 4271.060366719316, 4282.464691913511, 4308.3968244445805, 4311.202427550913, 4331.047169622678, 5827.650340979555, 5845.824625261164, 6077.665728384981, 6119.694015299217, 6159.1069294951985, 6315.905261421082, 6366.936330636634, 6376.489880809524, 6384.553081284358, 6384.6169229846355, 6183.412575805291, 6185.165002724574, 6190.380961903774, 6194.59735117225, 6196.566240363221, 5152.819651312261, 5160.535551800356, 5386.5152136307925, 5393.379761327419, 5428.592855535771, 6523.8695226095215, 6582.539222254492, 6686.5653732507235, 6705.899411508832, 6717.0, 6363.809085727436, 6369.172007638977, 6370.394812492806, 6373.490120790233, 6382.234131904015, 6309.621422714468, 6609.4712423007, 6647.6676166192465, 6685.364890335411, 6710.698018589273, 6069.939300606938, 6094.878102437838, 6108.633481991094, 6114.2357205349335, 6124.724387402489, 6324.209473815773, 6363.045543168561, 6369.394907483782, 6373.3945275198785, 6385.042243663488, 6110.083487476914, 6168.25980882297, 6176.907346389898, 6186.1648677427975, 6188.164597779242, 5930.733117009831, 5967.045272756338, 6073.14975903365, 6078.969605151946, 6098.481629061579, 6126.356732543019, 6168.0, 6170.290416601969, 6172.0, 6174.44430001302, 5962.0, 6152.846178845564, 6232.688365581612, 6255.874882502233, 6256.874862502634, 5849.824505264849, 5939.554533409925, 5995.400459953969, 6011.278646562266, 6026.969865150646], "value": 5781.437802010342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.6695437484694, 823.3701218567795, 846.9110743371948, 912.320321360586, 938.5494962418044, 41911.37132943005, 43687.563124368746, 47735.52264477354, 47744.52255477444, 47960.0, 44871.0, 45017.77491112548, 45086.54913450865, 45112.77443612785, 45304.0, 9188.999999999984, 9270.39742416744, 10091.344062635904, 10363.430011349374, 10644.095251903598, 10273.845892311621, 10275.332103413291, 10288.537015834268, 10317.793644127112, 10336.844947325759, 10354.2234332425, 10370.014848589371, 10389.013043760831, 10415.375077495337, 10425.739356516073, 10233.283670143093, 10252.89747102527, 10336.328138671, 10349.9482502587, 10352.534135963824, 9991.250656200742, 10041.899581004243, 10077.294589378746, 10079.49602519871, 10108.0, 36654.63345366539, 36758.816205918796, 36940.0, 36983.0, 37007.07482312937, 4030.1738143680477, 4093.89765255868, 4163.521195062576, 4165.812538435777, 4185.518665353493, 26398.868005660042, 26431.867840660867, 26915.32711682204, 26915.865420672966, 27332.0, 4197.895052623679, 4225.746455212697, 4239.385289133089, 4250.511191213019, 4314.417553630251, 224035.99999999837, 226302.0, 228829.0, 230978.0, 231202.0, 46650.0, 46916.76541617338, 46956.29565556519, 47160.76419617949, 47294.76352618215, 48678.75660621674, 48721.269180962314, 48818.26772598414, 48838.75580622145, 48965.0, 15608.29762660683, 15755.0, 15757.212139392985, 15766.369345226292, 15822.920885395499, 13537.661558461117, 13593.388297526635, 13640.863591364157, 13685.726285474235, 13718.38267277955, 12696.17474864131, 12795.232286062866, 12813.551525696555, 12870.935645321713, 12961.935190323988, 5508.98921893514, 5574.526165275997, 5618.91571626426, 5732.197492351074, 5735.684537350402, 1000.6247657128577, 1006.993006993007, 1019.2101121630795, 1033.214756784849, 1039.2465462539599, 27381.0, 27664.77940921042, 27945.16164515027, 28407.57388639172, 28600.0, 1093.420487141816, 1097.4457898761075, 1106.607154460155, 1114.894085061934, 1128.2046157458972, 14341.498047568493, 14376.496822611158, 14505.637359065897, 14842.183679897493, 14921.253937303092, 319954.0, 321759.0, 322419.0, 322908.0, 324264.0, 57774.4222557769, 58536.707316463144, 58554.0, 58568.414315857146, 58873.0, 1492.6939977304626, 1521.5283262188757, 1546.0, 1576.9763453548205, 1581.6994770993704, 26745.598816018166, 26994.595081073407, 27691.861540692167, 27908.0, 27940.441191175654, 44461.11077778491, 44465.777671111435, 44490.55509444864, 44503.55496444994, 44678.3298250533, 303218.48390757904, 303733.0, 304104.0, 304231.0, 304893.0, 29467.410651786417, 30198.547021794253, 32248.35503289968, 32547.511787322735, 32749.836250818593, 39298.60701393064, 39416.21167576575, 39492.80253598829, 39928.0, 40139.598604014755, 30999.380012400077, 31008.379832403676, 31052.68947310498, 31077.378452431276, 31384.529232061082, 31028.844855775576, 31411.528827067155, 31426.68573314329, 31478.213044674067, 31616.841915790275, 34904.0, 35259.82370088133, 35268.118297042776, 35281.47077793784, 35662.0, 29549.55675664824, 29665.5550166752, 29683.40633187281, 30001.099967001024, 30183.245418864703, 24174.516509669356, 24409.75590244075, 24473.51052978966, 24511.63232551549, 24810.379740506633], "value": 18517.305027136084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.5802145982774, 453.7391000174898, 457.39623696720344, 465.13717054863247, 476.4758765358105, 19606.50983725406, 21496.46258843528, 22051.558968820613, 22353.664695029587, 22719.999999999978, 20349.0, 20921.895390523026, 21834.890825545852, 22442.663360049613, 22469.101235950544, 6480.578762380442, 6591.077249185118, 6684.197896252432, 6993.440524758007, 7301.817454563626, 7332.7066917323245, 7489.36340411063, 7511.474196806225, 7525.849483010336, 7549.962250188769, 7644.46488745788, 7690.115636701767, 7711.074671039483, 7718.421118416113, 7731.574763388039, 7466.77599672008, 7587.924120758805, 7650.540967541965, 7695.192004839495, 7700.653470593837, 7360.815979600553, 7370.336669699753, 7413.8517229655645, 7471.7011319547155, 7499.737509187153, 24854.130105446402, 24855.751442485704, 25122.874385627954, 25489.980400783945, 25566.744332556624, 3146.763992700534, 3219.114743445548, 3220.473220473225, 3221.114193596756, 3264.298175892171, 15452.459163929208, 15970.281337339848, 16011.839881601269, 16209.351625934949, 16455.42406015784, 2095.518030852897, 2106.0, 2134.0930104705594, 2163.5240247145603, 2172.1420039084474, 114013.42993285063, 117407.0, 117973.41013294965, 118948.40525797315, 121336.0, 17783.73324400135, 18289.26842926268, 18764.81235187658, 18805.435836924913, 18862.622747545247, 31357.8432107838, 31421.528677069862, 31761.888333908202, 31768.523472147936, 31938.041858744276, 10007.199424046059, 10024.749381265381, 10206.897931020743, 10456.477176141314, 10471.895281047244, 8548.273396761346, 8549.615267312862, 8558.657653693783, 8706.303495720327, 8765.737027889174, 8833.160849719266, 8885.644574217089, 9016.368854180144, 9291.210247128934, 9336.626534938663, 3541.6281290464644, 3688.2070354873294, 3720.1257704439436, 3874.8256328465286, 3918.333883239799, 960.9903900961041, 967.1730670276953, 977.4282045003611, 977.9070988256104, 979.1383582447543, 19998.50003749918, 20446.795532044787, 20838.58322833565, 21031.8948405257, 21158.259460918795, 979.4759803505233, 981.1415011864618, 985.4629227071264, 987.8320685483485, 1004.7337455574278, 11160.720981975353, 11455.83535664264, 11668.591599293984, 11670.766584668429, 11711.414429278673, 639066.0, 648016.0, 653051.0, 654099.0, 680954.0, 114279.0, 115251.42374288243, 118858.4057079709, 119137.40431297962, 119646.0, 1282.6665067082627, 1291.4511332683571, 1311.8622544632676, 1313.835770528684, 1316.8551459339465, 17293.56766080858, 17684.823151768316, 18086.276548937894, 18178.181981810587, 18344.357947471774, 47235.0, 53274.0, 53444.46555534395, 54946.450535494136, 55198.724006379714, 63168.0, 64061.35938640554, 65030.0, 73808.26191738014, 76248.0, 12519.812202816784, 12982.675433114247, 13031.0, 13056.281904495345, 13076.476940922257, 14542.054766440147, 14574.417023318949, 14593.562193134223, 14913.478028268959, 14997.475088371855, 12634.620961371174, 12649.430775614936, 12685.93657031709, 12772.169808962388, 12818.74362512726, 11726.885945835133, 11734.237274577124, 11873.643790686294, 11876.643700688648, 12003.699907502383, 12028.75942481128, 12174.513019479476, 13121.93439032837, 13199.736005279648, 13362.131461454974, 12954.676133096747, 13039.282839443922, 13050.608481745563, 13253.403596837972, 13450.663733406353, 12555.623331300076, 12578.308193049104, 12955.417006234553, 12989.090763646454, 13092.410841511964], "value": 11661.89071640008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.4955214331403, 1583.0897234090398, 1590.165163289273, 1593.625498007968, 1613.8224795272517, 10047.899521004787, 10334.7416314592, 10925.672229833099, 11669.008134308584, 11686.649400517987, 11217.887821121787, 11613.361265130414, 11620.767584648302, 11623.360715160663, 11623.65129046128, 2512.937176570587, 2550.744925507453, 2567.422329975759, 2567.9871600641973, 2569.498947705198, 2469.09877894569, 2522.2055052658447, 2531.3798119460666, 2540.7078186008566, 2541.1995221505167, 2436.634504824273, 2461.716902556202, 2477.3930387055107, 2512.1207577347964, 2514.8491090534535, 2349.8472599281076, 2364.9645255321184, 2376.9762302376926, 2380.226426411406, 2384.630382290739, 2313.1788215183706, 2370.573296806574, 2376.0733314007553, 2383.285014495644, 2383.9523209535714, 11757.118216133824, 12008.099392545593, 12152.696182595506, 12158.270503769802, 12165.391730413445, 6024.759009639609, 6161.44546990773, 6175.197224360804, 6186.319504854462, 6195.1946246988055, 3536.3104194682046, 3609.3322735294055, 3672.8714494992546, 3676.227992121631, 3679.8344074516444, 1275.3431982529005, 1283.2941881964975, 1328.2229895511139, 1350.5070649213064, 1375.5185685010267, 16893.746593801105, 17626.383076592258, 17754.289828406847, 17985.0, 18332.45002649936, 4754.144254034238, 4780.943025540275, 4802.303665968485, 4840.2255639098275, 4876.707397556158, 13108.279044652445, 13131.60605181846, 13294.268815215257, 13300.667483312995, 13358.198508089547, 5915.964706176488, 6000.159977603139, 6015.248093988252, 6033.396660333931, 6041.184440100618, 4544.522825103382, 5428.131498960148, 5559.138333558305, 5569.415211402826, 5590.301212348457, 3948.743331683489, 3994.8801535953967, 4011.8997025074605, 4079.2453396121814, 4088.2232375848494, 1034.886162522137, 1037.4553359486179, 1046.2257929132388, 1051.3901936876593, 1051.663467690347, 1012.2205901455985, 1040.9375437473775, 1056.4612047855649, 1061.0715623829149, 1061.5753698520653, 6653.301403352578, 6733.797986060426, 6771.085903403076, 6794.626295553792, 6883.483738719616, 1005.9446730429751, 1011.7369483934083, 1034.2088302448633, 1063.9734006649742, 1084.5932775209296, 4185.748855068706, 4354.281543545279, 4693.22561777303, 4757.215059515211, 4790.7365094920115, 14947.1779052151, 15633.0, 15635.14006729618, 15658.0, 15664.765028524582, 14398.568042958728, 14927.477538286108, 15573.454929077428, 15784.21078946071, 15794.131322777357, 11025.44872756359, 11203.327800332007, 11208.383538905275, 11252.774944501065, 11253.0, 7274.781756547312, 7476.738314158978, 7622.733204337822, 7710.337345920114, 7997.960010199912, 13394.93302533481, 13415.932920335335, 13416.597502074954, 13535.729285414434, 13675.042747007614, 13627.659308517366, 13629.522966696119, 13750.724985500434, 13914.09558378702, 13926.373313201133, 9828.11546960777, 9938.0, 9959.751006224902, 10064.798704026025, 10077.244206684381, 10971.561137554727, 10980.286281391684, 11109.388983605979, 11249.66251012471, 11322.547098115983, 9188.770280743034, 9419.717408477756, 9529.237660987243, 9557.569909354235, 9961.501924903581, 9546.18857397129, 9578.233741300819, 9644.0, 9645.614175432904, 9790.706278811647, 8850.778730531789, 8991.955040224757, 9038.502882341534, 9050.864237036318, 9075.183233509017, 6776.0, 6782.186137663314, 6825.419839313714, 6835.077264569419, 6895.310468953065, 6783.423409010092, 6804.523683342317, 6827.829304267433, 6857.382835544825, 6986.16166060076], "value": 5524.458427911147, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.85029389419805, 419.5301262585904, 435.8104224662274, 447.186121259308, 448.5805771603551, 5163.3545806774155, 5256.632035757499, 5360.5443537299325, 5371.274877891484, 5393.487618676224, 5184.455632158616, 5250.501202385777, 5271.525562699366, 5283.973580132104, 5291.153415453528, 4538.387317712108, 4549.6360291176625, 4555.772211389434, 4558.61251793598, 4576.359309696645, 4419.0, 4472.865814025585, 4519.909601807962, 4538.546145385468, 4547.567981041796, 4526.785981952818, 4529.184746745585, 4535.614472769818, 4544.931826022612, 4554.72671639701, 4532.75628563863, 4549.6360291176625, 4558.407407037081, 4574.359589657451, 4577.9928415748645, 4194.958050419487, 4381.802818873159, 4390.538993405678, 4392.352867674622, 4408.316710909814, 5128.820371314581, 5186.974065129651, 5195.766190521435, 5197.192596847938, 5212.817551385721, 5383.070358638177, 5385.8114965976, 5418.539424148952, 5418.810341638024, 5420.0, 5338.505218538815, 5564.527015203713, 5577.191307260425, 5604.411536788619, 5669.518090962273, 4896.36347274852, 4903.670756390721, 4924.0, 4933.679310844819, 4944.406671199443, 5851.912221316641, 5853.955942909705, 5875.795461930294, 5885.61743486672, 5907.7464225757385, 4510.345999830006, 4776.8328108516735, 4805.6155507559315, 4814.518548145157, 5152.330197074356, 4851.762800485924, 4852.708837469763, 4862.32249873793, 4873.586659868598, 4880.463149053601, 5098.311727916758, 5184.585233181337, 5190.532852043259, 5192.61055420845, 5197.896042079137, 5470.753816078286, 5478.287822583039, 5557.472040156179, 5568.8862227554655, 5612.747426365823, 1647.4728087012281, 1672.8996260224426, 1673.0547240808903, 1675.0619652994362, 1682.8064772551313, 1251.2680082152042, 1280.1359082619194, 1290.5676598339662, 1297.5199176304639, 1310.4234136979699, 5473.890522189534, 5490.478404551562, 5497.0, 5514.007478653801, 5514.779408823682, 5623.834823592864, 5644.9435505644415, 5664.943350566442, 5666.660000399989, 5688.544916406678, 5199.532042116228, 5451.972740136274, 5453.972730136324, 5464.0, 5501.019632932142, 3005.2637103909246, 3009.774266929945, 3010.78924475289, 3023.6069310989433, 3033.4084853453805, 5862.618929769551, 5903.616264942765, 5961.761529538857, 5989.64062156272, 6008.188894499274, 5735.910177066344, 5794.884102318014, 5804.88390232193, 5823.82528524145, 5828.591998560145, 5932.79235226765, 5973.551983601247, 5990.0, 6006.609570377911, 6011.849703757353, 5374.838754837361, 5613.438656134354, 5679.801206957736, 5699.774548472098, 5713.342965559014, 5467.835964921059, 5537.723113844372, 5585.357683866408, 5649.858753531194, 5659.688717120598, 5769.480746732815, 5907.645541267538, 5938.061938061938, 5984.551158663031, 6035.69821508914, 4759.976605029935, 4778.068276686013, 4787.736674482937, 4794.2808578713475, 4794.845541043462, 5630.4369563043365, 5768.2501274834, 5786.652800831964, 5795.478406943395, 5854.970725146347, 5583.246261754611, 5596.440355964371, 5628.549716022791, 5646.265985421869, 5654.46282603152, 5533.667979921218, 5619.831405057855, 5621.8594535136945, 5655.830325090089, 5662.292213473316, 5480.506754392124, 5549.472800083986, 5580.748866301107, 5581.190727344593, 5581.6371935824045, 5640.971795140998, 5642.238297829905, 5687.1753595729215, 5696.886062278649, 5707.229524014371, 5405.270288511158, 5439.864003399946, 5499.175123731312, 5507.449255074461, 5537.280153580009], "value": 4532.34544848229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.5287973813747, 912.662314943471, 915.9771005724856, 918.6187732091182, 948.6205517792885, 14822.258887055645, 15662.686746265068, 15678.137702426377, 15683.137427441487, 15732.685346293081, 16748.246328915197, 16944.0680762558, 16976.915115424435, 17000.659986800256, 17018.0, 858.2361698088706, 871.7210492642373, 874.4185116897288, 890.7773056735816, 897.2642433204775, 885.5306687455659, 887.5739644970419, 888.1296329596998, 889.0265159650173, 889.8442772514784, 948.0519480519481, 956.9186619137382, 958.7411398922287, 958.9089036541517, 960.9903900961006, 954.0411886054471, 957.0190554681437, 957.033396269769, 957.3011701457905, 958.4105774948426, 698.7903628911306, 699.3461113858508, 700.0444393403019, 702.0171759536638, 702.3117345001875, 16269.918650406791, 16283.918580407022, 16285.348586056543, 16420.1789910504, 16463.588410289718, 15652.921735391365, 16160.919195404065, 16197.352105915748, 16591.41930032443, 16665.0, 13145.277009764459, 13498.797518037238, 13729.794053089212, 13825.446982120704, 13887.166769993732, 4045.4538637283886, 4052.4529188559463, 4054.1283624020684, 4101.241270364992, 4117.258893399187, 63896.0, 69606.0, 75388.62305688491, 80113.19886801115, 81001.18998809996, 12759.808602870964, 13001.0, 13131.146475479063, 13244.0, 13364.331783410791, 23115.884420578124, 23288.417789555057, 23353.883230584077, 23453.88273058624, 23511.529769404515, 8772.947246330481, 8810.559472026373, 8952.641894324153, 8981.550922453851, 9188.632454701738, 4969.180085285887, 5067.594592432597, 5073.289739436482, 5097.592192624581, 5098.439171691111, 3587.551556055493, 3914.236723838824, 4057.9797101014306, 4141.52372477169, 4147.149834283965, 718.3175982816346, 735.0481126940625, 740.2190688823235, 742.5210739073375, 747.2228881962807, 709.3119673916293, 727.3889932456761, 729.5950747335173, 733.9559626422432, 750.6171852355338, 11493.252938558968, 12027.338496382608, 12053.156279060382, 12471.625851224479, 12477.688057798629, 809.6356639512243, 828.2173346187915, 828.2338836576143, 849.0914721248329, 852.2244757270854, 5645.774169033192, 5669.121286200645, 5701.2018317435595, 5803.245578074823, 5861.501772349398, 69667.30332696608, 84009.57995209986, 85341.14658853332, 86356.0, 86972.56513717391, 68424.65787671029, 68557.65721171461, 68987.31012689909, 69106.308936911, 70170.29829701739, 53816.461835381146, 55304.0, 55804.0, 58789.0, 63416.36583634197, 10969.067629251284, 11369.2609980351, 11388.886111138783, 11585.6524304271, 11651.12616553745, 41489.792551037055, 42387.78806106073, 42615.7869210652, 42990.78504607457, 43189.13621727611, 48641.37906898839, 48895.0, 49002.264966026254, 49024.0, 49388.0, 13035.543755968496, 13160.341982901009, 13237.338133093499, 13308.800367994294, 13318.533851315546, 16325.346986120423, 16427.0, 16729.0, 16827.07451090153, 17080.57298567546, 15880.285387157375, 15967.920160399124, 16540.42108526244, 16763.413280535122, 16768.916155419145, 15688.215589220721, 15839.366425342858, 15888.443904463289, 16681.582960426087, 16760.413385531447, 15637.84362156364, 15690.686186276438, 16323.102229377499, 16466.42367517131, 16478.176091195633, 11453.656390308304, 11538.48076836561, 11751.118666100248, 11783.823242651195, 11999.940000299943, 12545.623631291075, 12558.811617825922, 12717.300548469922, 12920.870791291967, 12940.676483087622], "value": 7939.952893703022, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 116.0, 112.0, 114.0, 113.0, 118.0, 113.0, 113.0, 119.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 120.0, 161.0, 119.0, 117.0, 117.0, 116.0, 140.0, 116.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 167.0, 161.0, 163.0, 163.0, 164.0, 163.0, 164.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 112.0, 76.0, 78.0, 77.0, 79.0, 101.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 111.0, 84.0, 83.0, 83.0, 96.0, 83.0, 82.0, 115.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 115.0, 113.0, 118.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 60.0, 58.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 80.0, 80.0, 77.0, 86.0, 84.0, 77.0, 79.0, 76.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 133.0, 138.0, 132.0, 122.0, 132.0, 123.0, 129.0, 167.0, 138.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 159.0, 164.0, 160.0, 159.0, 158.0, 165.0, 164.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 61.0, 69.0, 64.0, 63.0, 63.0, 60.0, 62.0], "value": 63.4, "unit": "score"}]}]} 02:01:09 INFO - Return code: 0 02:01:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:01:10 ERROR - # TBPL SUCCESS # 02:01:10 INFO - Running post-action listener: _resource_record_post_action 02:01:10 INFO - [mozharness: 2017-04-05 09:01:10.034943Z] Finished run-tests step (success) 02:01:10 INFO - Running post-run listener: _resource_record_post_run 02:01:10 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 362692608; Read time: 24; Write time: 197184 02:01:10 INFO - TinderboxPrint: CPU usage
13.5% 02:01:10 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 02:01:10 INFO - TinderboxPrint: I/O write bytes / time
362,692,608 / 197,184 02:01:10 INFO - TinderboxPrint: CPU idle
8,230.9 (86.5%) 02:01:10 INFO - TinderboxPrint: CPU user
1,220.3 (12.8%) 02:01:10 INFO - TinderboxPrint: Swap in / out
0 / 0 02:01:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110972928; Read time: 0; Write time: 86592 02:01:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251719680; Read time: 24; Write time: 110592 02:01:10 INFO - Running post-run listener: _upload_blobber_files 02:01:10 INFO - Blob upload gear active. 02:01:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:01:10 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 02:01:10 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:01:10 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:01:11 INFO - (blobuploader) - INFO - Open directory for files ... 02:01:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:01:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:01:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:11 INFO - (blobuploader) - INFO - Done attempting. 02:01:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:01:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:01:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:12 INFO - (blobuploader) - INFO - Done attempting. 02:01:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:01:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:16 INFO - (blobuploader) - INFO - Done attempting. 02:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:01:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:17 INFO - (blobuploader) - INFO - Done attempting. 02:01:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:01:17 INFO - Return code: 0 02:01:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:01:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:01:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1dc0396711d094d665658797f4f57d798ec2cb2efbda442c80d737c4f934696e73fed1612099eb6077a8af84dda4b7a06a3eff40dd1cc691bfb023ec4beff203", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a75a9bf925d650d8162ba23da3096dcbcdea163e77494e1ee960fcdb0811c2cf66ec67947fa5c7da10ef9615946630672a506ebde27abab71cbd25ee1c24cef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bc58fddd4e939f81398bfdf93a48798b98bf82d0131ed7406b4b1aa7482245ef72d580e6d3694ea8b90e50bc16726302019f9042b47ef8b5e6c134937331970c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50395ec84364d5014bdfb3dd8f51231eb609dda382d4916300caa4774bb97469a7f901ecc3c688ef25409b233e2b54625a3f8667e4a256198f79c5dc401d2d9f"} 02:01:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:01:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:01:17 INFO - Contents: 02:01:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1dc0396711d094d665658797f4f57d798ec2cb2efbda442c80d737c4f934696e73fed1612099eb6077a8af84dda4b7a06a3eff40dd1cc691bfb023ec4beff203", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a75a9bf925d650d8162ba23da3096dcbcdea163e77494e1ee960fcdb0811c2cf66ec67947fa5c7da10ef9615946630672a506ebde27abab71cbd25ee1c24cef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bc58fddd4e939f81398bfdf93a48798b98bf82d0131ed7406b4b1aa7482245ef72d580e6d3694ea8b90e50bc16726302019f9042b47ef8b5e6c134937331970c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50395ec84364d5014bdfb3dd8f51231eb609dda382d4916300caa4774bb97469a7f901ecc3c688ef25409b233e2b54625a3f8667e4a256198f79c5dc401d2d9f"} 02:01:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:01:17 INFO - Copying logs to upload dir... 02:01:17 INFO - mkdir: /builds/slave/test/build/upload/logs 02:01:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.695653 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-05 02:01:16.583338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 02:01:16.587022) ========= 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=483e410453545d07cca6935c000001ab-1491381623.118500-1116890065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1dc0396711d094d665658797f4f57d798ec2cb2efbda442c80d737c4f934696e73fed1612099eb6077a8af84dda4b7a06a3eff40dd1cc691bfb023ec4beff203", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a75a9bf925d650d8162ba23da3096dcbcdea163e77494e1ee960fcdb0811c2cf66ec67947fa5c7da10ef9615946630672a506ebde27abab71cbd25ee1c24cef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bc58fddd4e939f81398bfdf93a48798b98bf82d0131ed7406b4b1aa7482245ef72d580e6d3694ea8b90e50bc16726302019f9042b47ef8b5e6c134937331970c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50395ec84364d5014bdfb3dd8f51231eb609dda382d4916300caa4774bb97469a7f901ecc3c688ef25409b233e2b54625a3f8667e4a256198f79c5dc401d2d9f"} build_url:https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/H5W_OCrhRfOt9Dy5Q25ARg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1dc0396711d094d665658797f4f57d798ec2cb2efbda442c80d737c4f934696e73fed1612099eb6077a8af84dda4b7a06a3eff40dd1cc691bfb023ec4beff203", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a75a9bf925d650d8162ba23da3096dcbcdea163e77494e1ee960fcdb0811c2cf66ec67947fa5c7da10ef9615946630672a506ebde27abab71cbd25ee1c24cef9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bc58fddd4e939f81398bfdf93a48798b98bf82d0131ed7406b4b1aa7482245ef72d580e6d3694ea8b90e50bc16726302019f9042b47ef8b5e6c134937331970c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/50395ec84364d5014bdfb3dd8f51231eb609dda382d4916300caa4774bb97469a7f901ecc3c688ef25409b233e2b54625a3f8667e4a256198f79c5dc401d2d9f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 02:01:16.617863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 02:01:16.618672) ========= 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=483e410453545d07cca6935c000001ab-1491381623.118500-1116890065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 02:01:16.702504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 02:01:16.703259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 02:01:16.703822) ========= ========= Total master_lag: 0.18 =========