builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1485898645.84 results: success (0) buildid: 20170131114308 builduid: 1eada5e794b344788fc4a0ff781b4ca1 revision: f271c045f7abe68f3c4e650f3901be6f32892b48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:25.837720) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:25.838178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:25.838447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:25.861763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:25.862104) ========= 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=d2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-31 13:37:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.4M=0s 2017-01-31 13:37:26 (45.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:26.017587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:26.017932) ========= 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=d2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016884 ========= master_lag: 0.36 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:26.393366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 13:37:26.393748) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f271c045f7abe68f3c4e650f3901be6f32892b48 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f271c045f7abe68f3c4e650f3901be6f32892b48 --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=d2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-31 13:37:26,831 truncating revision to first 12 chars 2017-01-31 13:37:26,831 Setting DEBUG logging. 2017-01-31 13:37:26,831 attempt 1/10 2017-01-31 13:37:26,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f271c045f7ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 13:37:27,618 unpacking tar archive at: mozilla-beta-f271c045f7ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.116790 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 13:37:27.526802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:27.527141) ========= script_repo_revision: f271c045f7abe68f3c4e650f3901be6f32892b48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:27.527547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:27.527841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 13:37:27.537402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-31 13:37:27.537772) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=d2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:37:28 INFO - MultiFileLogger online at 20170131 13:37:28 in /builds/slave/test 13:37:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:37:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:37:28 INFO - {'append_to_log': False, 13:37:28 INFO - 'base_work_dir': '/builds/slave/test', 13:37:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:37:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:37:28 INFO - 'branch': 'Mozilla-Beta', 13:37:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:37:28 INFO - 'config_files': ('talos/linux_config.py',), 13:37:28 INFO - 'default_actions': ('clobber', 13:37:28 INFO - 'read-buildbot-config', 13:37:28 INFO - 'download-and-extract', 13:37:28 INFO - 'populate-webroot', 13:37:28 INFO - 'create-virtualenv', 13:37:28 INFO - 'install', 13:37:28 INFO - 'run-tests'), 13:37:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:37:28 INFO - 'download_minidump_stackwalk': True, 13:37:28 INFO - 'download_symbols': 'ondemand', 13:37:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:37:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:37:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:37:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:37:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:37:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:37:28 INFO - 'installer_path': 'installer.exe', 13:37:28 INFO - 'log_level': 'info', 13:37:28 INFO - 'log_name': 'talos', 13:37:28 INFO - 'log_to_console': True, 13:37:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:37:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:37:28 INFO - 'opt_config_files': (), 13:37:28 INFO - 'pip_index': False, 13:37:28 INFO - 'sps_profile': False, 13:37:28 INFO - 'sps_profile_interval': 0, 13:37:28 INFO - 'suite': 'dromaeojs', 13:37:28 INFO - 'system_bits': '32', 13:37:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:37:28 INFO - 'title': 'talos-linux64-ix-043', 13:37:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:37:28 INFO - 'use_talos_json': True, 13:37:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:37:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:37:28 INFO - 'work_dir': 'build'} 13:37:28 INFO - [mozharness: 2017-01-31 21:37:28.073537Z] Running clobber step. 13:37:28 INFO - Running pre-action listener: _resource_record_pre_action 13:37:28 INFO - Running main action method: clobber 13:37:28 INFO - rmtree: /builds/slave/test/build 13:37:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:37:29 INFO - Running post-action listener: _resource_record_post_action 13:37:29 INFO - [mozharness: 2017-01-31 21:37:29.059735Z] Finished clobber step (success) 13:37:29 INFO - [mozharness: 2017-01-31 21:37:29.059833Z] Running read-buildbot-config step. 13:37:29 INFO - Running pre-action listener: _resource_record_pre_action 13:37:29 INFO - Running main action method: read_buildbot_config 13:37:29 INFO - Using buildbot properties: 13:37:29 INFO - { 13:37:29 INFO - "project": "", 13:37:29 INFO - "product": "firefox", 13:37:29 INFO - "script_repo_revision": "production", 13:37:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:37:29 INFO - "repository": "", 13:37:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:37:29 INFO - "buildid": "20170131114308", 13:37:29 INFO - "pgo_build": "True", 13:37:29 INFO - "basedir": "/builds/slave/test", 13:37:29 INFO - "buildnumber": 117, 13:37:29 INFO - "slavename": "talos-linux64-ix-043", 13:37:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:37:29 INFO - "platform": "ubuntu64_hw", 13:37:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:37:29 INFO - "branch": "mozilla-beta", 13:37:29 INFO - "repo_path": "releases/mozilla-beta", 13:37:29 INFO - "revision": "f271c045f7abe68f3c4e650f3901be6f32892b48", 13:37:29 INFO - "stage_platform": "linux64-pgo", 13:37:29 INFO - "builduid": "1eada5e794b344788fc4a0ff781b4ca1", 13:37:29 INFO - "slavebuilddir": "test" 13:37:29 INFO - } 13:37:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 13:37:29 INFO - Running post-action listener: _resource_record_post_action 13:37:29 INFO - [mozharness: 2017-01-31 21:37:29.062267Z] Finished read-buildbot-config step (success) 13:37:29 INFO - [mozharness: 2017-01-31 21:37:29.062363Z] Running download-and-extract step. 13:37:29 INFO - Running pre-action listener: _resource_record_pre_action 13:37:29 INFO - Running main action method: download_and_extract 13:37:29 INFO - mkdir: /builds/slave/test/build/tests 13:37:29 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')]} 13:37:29 INFO - trying https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:37:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:37:29 INFO - Downloaded 1327 bytes. 13:37:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:37:29 INFO - Using the following test package requirements: 13:37:29 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 13:37:29 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:37:29 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 13:37:29 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'jsshell-linux-x86_64.zip'], 13:37:29 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:37:29 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 13:37:29 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 13:37:29 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 13:37:29 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:37:29 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:37:29 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:37:29 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:37:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 13:37:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:37:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 13:37:30 INFO - Http code: 200 13:37:30 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 13:37:30 INFO - x-amz-cf-id: jB46PQSHzoutU9pnhRlZEvIZ3o5_JLLYPMoIJKOj-4y61AchMYsvQQ== 13:37:30 INFO - x-amz-version-id: tTBwtYiqpHOFlW53nvRAu.om.PXVcm5E 13:37:30 INFO - Expected file size: 21955365 13:37:30 INFO - Obtained file size: 21955365 13:37:34 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:37:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 13:37:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:37:34 INFO - Fetch https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 13:37:35 INFO - Http code: 200 13:37:35 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 13:37:35 INFO - x-amz-cf-id: Gg-SffuK0XaVTFCfxgcsbYF9Blmj3tFJcFhdxxbTY5veAA1h9K58Lg== 13:37:35 INFO - x-amz-version-id: tTBwtYiqpHOFlW53nvRAu.om.PXVcm5E 13:37:35 INFO - Expected file size: 21955365 13:37:35 INFO - Obtained file size: 21955365 13:37:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 13:37:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:37:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 13:37:40 INFO - Http code: 200 13:37:40 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:37:40 INFO - x-amz-cf-id: HPGdx2Nf5fZOdJfWjv9SZuEdBzH-Xu2VJgfnHzgWhMAmbBkuugohMA== 13:37:40 INFO - x-amz-version-id: XWpONDykdFTeovdeZ_r_aLkis9R_qAc7 13:37:40 INFO - Expected file size: 14402992 13:37:40 INFO - Obtained file size: 14402992 13:37:40 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')]} 13:37:40 INFO - trying https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:37:40 INFO - Downloading https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:37:42 INFO - Downloaded 57709840 bytes. 13:37:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:37:42 INFO - mkdir: /builds/slave/test/properties 13:37:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:37:42 INFO - Writing to file /builds/slave/test/properties/build_url 13:37:42 INFO - Contents: 13:37:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:37:42 INFO - Running post-action listener: _resource_record_post_action 13:37:42 INFO - Running post-action listener: set_extra_try_arguments 13:37:42 INFO - [mozharness: 2017-01-31 21:37:42.738579Z] Finished download-and-extract step (success) 13:37:42 INFO - [mozharness: 2017-01-31 21:37:42.738805Z] Running populate-webroot step. 13:37:42 INFO - Running pre-action listener: _resource_record_pre_action 13:37:42 INFO - Running main action method: populate_webroot 13:37:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:37:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:37:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:37:42 INFO - '--tppagecycles', 13:37:42 INFO - '7'], 13:37:42 INFO - 'tests': ['tsvgm']}}, 13:37:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:37:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:37:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:37:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:37:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['damp', 'tps']}, 13:37:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'tests': ['damp', 'tps']}, 13:37:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['dromaeo_dom']}, 13:37:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:37:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['basic_compositor_video']}, 13:37:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:37:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['a11yr', 13:37:42 INFO - 'ts_paint', 13:37:42 INFO - 'tpaint', 13:37:42 INFO - 'sessionrestore', 13:37:42 INFO - 'sessionrestore_no_auto_restore', 13:37:42 INFO - 'tabpaint']}, 13:37:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:37:42 INFO - 'ts_paint', 13:37:42 INFO - 'tpaint', 13:37:42 INFO - 'sessionrestore', 13:37:42 INFO - 'sessionrestore_no_auto_restore', 13:37:42 INFO - 'tabpaint']}, 13:37:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:37:42 INFO - 'ts_paint', 13:37:42 INFO - 'tpaint', 13:37:42 INFO - 'sessionrestore', 13:37:42 INFO - 'sessionrestore_no_auto_restore', 13:37:42 INFO - 'tabpaint']}, 13:37:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:37:42 INFO - 'ts_paint', 13:37:42 INFO - 'tpaint', 13:37:42 INFO - 'sessionrestore', 13:37:42 INFO - 'sessionrestore_no_auto_restore', 13:37:42 INFO - 'tabpaint']}, 13:37:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['a11yr', 13:37:42 INFO - 'ts_paint', 13:37:42 INFO - 'tpaint', 13:37:42 INFO - 'sessionrestore', 13:37:42 INFO - 'sessionrestore_no_auto_restore', 13:37:42 INFO - 'tabpaint']}, 13:37:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['a11yr', 13:37:42 INFO - 'ts_paint', 13:37:42 INFO - 'tpaint', 13:37:42 INFO - 'sessionrestore', 13:37:42 INFO - 'sessionrestore_no_auto_restore', 13:37:42 INFO - 'tabpaint']}, 13:37:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['tsvgx', 13:37:42 INFO - 'tsvgr_opacity', 13:37:42 INFO - 'tart', 13:37:42 INFO - 'tscrollx', 13:37:42 INFO - 'cart']}, 13:37:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:37:42 INFO - 'tsvgr_opacity', 13:37:42 INFO - 'tart', 13:37:42 INFO - 'tscrollx', 13:37:42 INFO - 'cart']}, 13:37:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'talos_options': ['--disable-e10s'], 13:37:42 INFO - 'tests': ['tp5o']}, 13:37:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'tests': ['tp5o']}, 13:37:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'talos_options': ['--disable-e10s', 13:37:42 INFO - '--xperf_path', 13:37:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:42 INFO - 'tests': ['tp5n']}, 13:37:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:42 INFO - 'talos_options': ['--xperf_path', 13:37:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:42 INFO - 'tests': ['tp5n']}}, 13:37:42 INFO - 'talos.zip': {'path': '', 13:37:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:37:42 INFO - Running post-action listener: _resource_record_post_action 13:37:42 INFO - [mozharness: 2017-01-31 21:37:42.756829Z] Finished populate-webroot step (success) 13:37:42 INFO - [mozharness: 2017-01-31 21:37:42.756916Z] Running create-virtualenv step. 13:37:42 INFO - Running pre-action listener: _resource_record_pre_action 13:37:42 INFO - Running main action method: create_virtualenv 13:37:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:37:42 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 13:37:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:37:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:37:42 INFO - Using real prefix '/usr' 13:37:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:37:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:37:45 INFO - Installing pip.................done. 13:37:45 INFO - Return code: 0 13:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:37:45 INFO - Reading from file tmpfile_stdout 13:37:45 INFO - Output received: 13:37:45 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) 13:37:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:37:45 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')]} 13:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:45 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')]} 13:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:45 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:37:45 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 13:37:45 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 13:37:45 INFO - Using env: {'DISPLAY': ':0', 13:37:45 INFO - 'HOME': '/home/cltbld', 13:37:45 INFO - 'LANG': 'en_US.UTF-8', 13:37:45 INFO - 'LANGUAGE': 'en_US:en', 13:37:45 INFO - 'LOGNAME': 'cltbld', 13:37:45 INFO - 'MAIL': '/var/mail/cltbld', 13:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:45 INFO - 'MOZ_NO_REMOTE': '1', 13:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:45 INFO - 'NO_EM_RESTART': '1', 13:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:45 INFO - 'PWD': '/builds/slave/test', 13:37:45 INFO - 'SHELL': '/bin/bash', 13:37:45 INFO - 'SHLVL': '1', 13:37:45 INFO - 'TERM': 'linux', 13:37:45 INFO - 'TMOUT': '86400', 13:37:45 INFO - 'USER': 'cltbld', 13:37:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:45 INFO - '_': '/tools/buildbot/bin/python'} 13:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:45 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 13:37:45 INFO - Cleaning up... 13:37:45 INFO - Return code: 0 13:37:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:37:45 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')]} 13:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:45 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')]} 13:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:45 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:37:45 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 13:37:45 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 13:37:45 INFO - Using env: {'DISPLAY': ':0', 13:37:45 INFO - 'HOME': '/home/cltbld', 13:37:45 INFO - 'LANG': 'en_US.UTF-8', 13:37:45 INFO - 'LANGUAGE': 'en_US:en', 13:37:45 INFO - 'LOGNAME': 'cltbld', 13:37:45 INFO - 'MAIL': '/var/mail/cltbld', 13:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:45 INFO - 'MOZ_NO_REMOTE': '1', 13:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:45 INFO - 'NO_EM_RESTART': '1', 13:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:45 INFO - 'PWD': '/builds/slave/test', 13:37:45 INFO - 'SHELL': '/bin/bash', 13:37:45 INFO - 'SHLVL': '1', 13:37:45 INFO - 'TERM': 'linux', 13:37:45 INFO - 'TMOUT': '86400', 13:37:45 INFO - 'USER': 'cltbld', 13:37:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:45 INFO - '_': '/tools/buildbot/bin/python'} 13:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:45 INFO - Downloading/unpacking psutil>=3.1.1 13:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:37:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:48 INFO - Installing collected packages: psutil 13:37:48 INFO - Running setup.py install for psutil 13:37:48 INFO - building 'psutil._psutil_linux' extension 13:37:48 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 13:37:48 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 13:37:48 INFO - building 'psutil._psutil_posix' extension 13:37:48 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 13:37:48 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 13:37:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:48 INFO - Successfully installed psutil 13:37:48 INFO - Cleaning up... 13:37:48 INFO - Return code: 0 13:37:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:37:48 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')]} 13:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:48 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')]} 13:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:48 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:37:48 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 13:37:48 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 13:37:48 INFO - Using env: {'DISPLAY': ':0', 13:37:48 INFO - 'HOME': '/home/cltbld', 13:37:48 INFO - 'LANG': 'en_US.UTF-8', 13:37:48 INFO - 'LANGUAGE': 'en_US:en', 13:37:48 INFO - 'LOGNAME': 'cltbld', 13:37:48 INFO - 'MAIL': '/var/mail/cltbld', 13:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:48 INFO - 'MOZ_NO_REMOTE': '1', 13:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:48 INFO - 'NO_EM_RESTART': '1', 13:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:48 INFO - 'PWD': '/builds/slave/test', 13:37:48 INFO - 'SHELL': '/bin/bash', 13:37:48 INFO - 'SHLVL': '1', 13:37:48 INFO - 'TERM': 'linux', 13:37:48 INFO - 'TMOUT': '86400', 13:37:48 INFO - 'USER': 'cltbld', 13:37:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:48 INFO - '_': '/tools/buildbot/bin/python'} 13:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:37:50 INFO - Installing collected packages: mozsystemmonitor 13:37:50 INFO - Running setup.py install for mozsystemmonitor 13:37:51 INFO - Successfully installed mozsystemmonitor 13:37:51 INFO - Cleaning up... 13:37:51 INFO - Return code: 0 13:37:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:37:51 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')]} 13:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:51 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')]} 13:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:51 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:37:51 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 13:37:51 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 13:37:51 INFO - Using env: {'DISPLAY': ':0', 13:37:51 INFO - 'HOME': '/home/cltbld', 13:37:51 INFO - 'LANG': 'en_US.UTF-8', 13:37:51 INFO - 'LANGUAGE': 'en_US:en', 13:37:51 INFO - 'LOGNAME': 'cltbld', 13:37:51 INFO - 'MAIL': '/var/mail/cltbld', 13:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:51 INFO - 'MOZ_NO_REMOTE': '1', 13:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:51 INFO - 'NO_EM_RESTART': '1', 13:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:51 INFO - 'PWD': '/builds/slave/test', 13:37:51 INFO - 'SHELL': '/bin/bash', 13:37:51 INFO - 'SHLVL': '1', 13:37:51 INFO - 'TERM': 'linux', 13:37:51 INFO - 'TMOUT': '86400', 13:37:51 INFO - 'USER': 'cltbld', 13:37:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:51 INFO - '_': '/tools/buildbot/bin/python'} 13:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:51 INFO - Downloading/unpacking jsonschema==2.5.1 13:37:51 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 13:37:51 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 13:37:51 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 13:37:51 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 13:37:51 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 13:37:51 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 13:37:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:37:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:37:53 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 13:37:53 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 13:37:53 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 13:37:53 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 13:37:53 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 13:37:53 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 13:37:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:37:53 INFO - warning: no files found matching '*.txt' 13:37:53 INFO - no previously-included directories found matching 'build' 13:37:53 INFO - no previously-included directories found matching 'dist' 13:37:53 INFO - no previously-included directories found matching '.git*' 13:37:53 INFO - Installing collected packages: jsonschema, functools32 13:37:53 INFO - Running setup.py install for functools32 13:37:53 INFO - warning: no files found matching '*.txt' 13:37:53 INFO - no previously-included directories found matching 'build' 13:37:53 INFO - no previously-included directories found matching 'dist' 13:37:53 INFO - no previously-included directories found matching '.git*' 13:37:53 INFO - Successfully installed jsonschema functools32 13:37:53 INFO - Cleaning up... 13:37:53 INFO - Return code: 0 13:37:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:53 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:37:53 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 13:37:53 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 13:37:53 INFO - Using env: {'DISPLAY': ':0', 13:37:53 INFO - 'HOME': '/home/cltbld', 13:37:53 INFO - 'LANG': 'en_US.UTF-8', 13:37:53 INFO - 'LANGUAGE': 'en_US:en', 13:37:53 INFO - 'LOGNAME': 'cltbld', 13:37:53 INFO - 'MAIL': '/var/mail/cltbld', 13:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:53 INFO - 'MOZ_NO_REMOTE': '1', 13:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:53 INFO - 'NO_EM_RESTART': '1', 13:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:53 INFO - 'PWD': '/builds/slave/test', 13:37:53 INFO - 'SHELL': '/bin/bash', 13:37:53 INFO - 'SHLVL': '1', 13:37:53 INFO - 'TERM': 'linux', 13:37:53 INFO - 'TMOUT': '86400', 13:37:53 INFO - 'USER': 'cltbld', 13:37:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:53 INFO - '_': '/tools/buildbot/bin/python'} 13:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:37:53 INFO - Cleaning up... 13:37:53 INFO - Return code: 0 13:37:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:37:54 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 13:37:54 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 13:37:54 INFO - Using env: {'DISPLAY': ':0', 13:37:54 INFO - 'HOME': '/home/cltbld', 13:37:54 INFO - 'LANG': 'en_US.UTF-8', 13:37:54 INFO - 'LANGUAGE': 'en_US:en', 13:37:54 INFO - 'LOGNAME': 'cltbld', 13:37:54 INFO - 'MAIL': '/var/mail/cltbld', 13:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:54 INFO - 'MOZ_NO_REMOTE': '1', 13:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:54 INFO - 'NO_EM_RESTART': '1', 13:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:54 INFO - 'PWD': '/builds/slave/test', 13:37:54 INFO - 'SHELL': '/bin/bash', 13:37:54 INFO - 'SHLVL': '1', 13:37:54 INFO - 'TERM': 'linux', 13:37:54 INFO - 'TMOUT': '86400', 13:37:54 INFO - 'USER': 'cltbld', 13:37:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:54 INFO - '_': '/tools/buildbot/bin/python'} 13:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:37:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:56 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 13:37:56 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 13:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:37:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:56 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 13:37:56 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 13:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:56 INFO - Downloading docopt-0.6.1.tar.gz 13:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:37:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:37:56 INFO - Running setup.py install for blobuploader 13:37:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:37:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:37:57 INFO - Running setup.py install for requests 13:37:57 INFO - Running setup.py install for docopt 13:37:57 INFO - Successfully installed blobuploader requests docopt 13:37:57 INFO - Cleaning up... 13:37:57 INFO - Return code: 0 13:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:57 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:37:57 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 13:37:57 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 13:37:57 INFO - Using env: {'DISPLAY': ':0', 13:37:57 INFO - 'HOME': '/home/cltbld', 13:37:57 INFO - 'LANG': 'en_US.UTF-8', 13:37:57 INFO - 'LANGUAGE': 'en_US:en', 13:37:57 INFO - 'LOGNAME': 'cltbld', 13:37:57 INFO - 'MAIL': '/var/mail/cltbld', 13:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:57 INFO - 'MOZ_NO_REMOTE': '1', 13:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:57 INFO - 'NO_EM_RESTART': '1', 13:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:57 INFO - 'PWD': '/builds/slave/test', 13:37:57 INFO - 'SHELL': '/bin/bash', 13:37:57 INFO - 'SHLVL': '1', 13:37:57 INFO - 'TERM': 'linux', 13:37:57 INFO - 'TMOUT': '86400', 13:37:57 INFO - 'USER': 'cltbld', 13:37:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:57 INFO - '_': '/tools/buildbot/bin/python'} 13:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:37:57 INFO - Running setup.py (path:/tmp/pip-e63xEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:37:57 INFO - Running setup.py (path:/tmp/pip-_rBlpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:37:57 INFO - Running setup.py (path:/tmp/pip-yI7aNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:37:58 INFO - Running setup.py (path:/tmp/pip-XDDgml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:37:58 INFO - Running setup.py (path:/tmp/pip-vu4g2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:37:58 INFO - Running setup.py (path:/tmp/pip-Sspe7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:37:58 INFO - Running setup.py (path:/tmp/pip-NVR_bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:37:58 INFO - Running setup.py (path:/tmp/pip-PqJcEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:37:58 INFO - Running setup.py (path:/tmp/pip-Wkzokk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:37:58 INFO - Running setup.py (path:/tmp/pip-ll16Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:37:58 INFO - Running setup.py (path:/tmp/pip-GntBCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:37:58 INFO - Running setup.py (path:/tmp/pip-v0jhnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:37:58 INFO - Running setup.py (path:/tmp/pip-z91DXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:37:58 INFO - Running setup.py (path:/tmp/pip-1kLlT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:58 INFO - Running setup.py (path:/tmp/pip-g9Ic9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:37:58 INFO - Running setup.py (path:/tmp/pip-SWQI0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:37:58 INFO - Running setup.py (path:/tmp/pip-bmTJc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:37:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:37:59 INFO - Running setup.py install for manifestparser 13:37:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Running setup.py install for mozcrash 13:37:59 INFO - Running setup.py install for mozdebug 13:37:59 INFO - Running setup.py install for mozdevice 13:37:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Running setup.py install for mozfile 13:37:59 INFO - Running setup.py install for mozhttpd 13:37:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Running setup.py install for mozinfo 13:37:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Running setup.py install for mozInstall 13:37:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:37:59 INFO - Running setup.py install for mozleak 13:37:59 INFO - Running setup.py install for mozlog 13:38:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:38:00 INFO - Running setup.py install for moznetwork 13:38:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:38:00 INFO - Running setup.py install for mozprocess 13:38:00 INFO - Running setup.py install for mozprofile 13:38:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:38:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:38:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:38:00 INFO - Running setup.py install for mozrunner 13:38:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:38:00 INFO - Running setup.py install for mozscreenshot 13:38:00 INFO - Running setup.py install for moztest 13:38:00 INFO - Running setup.py install for mozversion 13:38:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:38:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:38:00 INFO - Cleaning up... 13:38:00 INFO - Return code: 0 13:38:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:00 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:38:00 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 13:38:00 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 13:38:00 INFO - Using env: {'DISPLAY': ':0', 13:38:00 INFO - 'HOME': '/home/cltbld', 13:38:00 INFO - 'LANG': 'en_US.UTF-8', 13:38:00 INFO - 'LANGUAGE': 'en_US:en', 13:38:00 INFO - 'LOGNAME': 'cltbld', 13:38:00 INFO - 'MAIL': '/var/mail/cltbld', 13:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:00 INFO - 'MOZ_NO_REMOTE': '1', 13:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:00 INFO - 'NO_EM_RESTART': '1', 13:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:00 INFO - 'PWD': '/builds/slave/test', 13:38:00 INFO - 'SHELL': '/bin/bash', 13:38:00 INFO - 'SHLVL': '1', 13:38:00 INFO - 'TERM': 'linux', 13:38:00 INFO - 'TMOUT': '86400', 13:38:00 INFO - 'USER': 'cltbld', 13:38:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:00 INFO - '_': '/tools/buildbot/bin/python'} 13:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:38:01 INFO - Running setup.py (path:/tmp/pip-qZ9tV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:38:01 INFO - Running setup.py (path:/tmp/pip-tVx9fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:38:01 INFO - Running setup.py (path:/tmp/pip-Drcidt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:38:01 INFO - Running setup.py (path:/tmp/pip-mEgxR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:38:01 INFO - Running setup.py (path:/tmp/pip-GaWvDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:38:01 INFO - Running setup.py (path:/tmp/pip-L4Yom9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:38:01 INFO - Running setup.py (path:/tmp/pip-aMhlBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:38:01 INFO - Running setup.py (path:/tmp/pip-hz6hSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:38:01 INFO - Running setup.py (path:/tmp/pip-hihHTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:38:01 INFO - Running setup.py (path:/tmp/pip-tsOSxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:38:01 INFO - Running setup.py (path:/tmp/pip-tzDMXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:38:01 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:38:01 INFO - Running setup.py (path:/tmp/pip-tEkFal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:38:01 INFO - Running setup.py (path:/tmp/pip-4JfKnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:38:02 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)) 13:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:38:02 INFO - Running setup.py (path:/tmp/pip-RaC3Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:38:02 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)) 13:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:02 INFO - Running setup.py (path:/tmp/pip-0u6JoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:02 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)) 13:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:38:02 INFO - Running setup.py (path:/tmp/pip-Bw3zBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:38:02 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)) 13:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:38:02 INFO - Running setup.py (path:/tmp/pip-daKr60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:38:02 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)) 13:38:02 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)) 13:38:02 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)) 13:38:02 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)) 13:38:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:38:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:38:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:38:02 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 13:38:02 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 13:38:02 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 13:38:02 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 13:38:02 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 13:38:02 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 13:38:04 INFO - Downloading blessings-1.6.tar.gz 13:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:38:04 INFO - Installing collected packages: blessings 13:38:04 INFO - Running setup.py install for blessings 13:38:04 INFO - Successfully installed blessings 13:38:04 INFO - Cleaning up... 13:38:04 INFO - Return code: 0 13:38:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:38:04 INFO - Reading from file tmpfile_stdout 13:38:04 INFO - Current package versions: 13:38:04 INFO - argparse == 1.2.1 13:38:04 INFO - blessings == 1.6 13:38:04 INFO - blobuploader == 1.2.4 13:38:04 INFO - docopt == 0.6.1 13:38:04 INFO - functools32 == 3.2.3-2 13:38:04 INFO - jsonschema == 2.5.1 13:38:04 INFO - manifestparser == 1.1 13:38:04 INFO - mozInstall == 1.12 13:38:04 INFO - mozcrash == 1.0 13:38:04 INFO - mozdebug == 0.1 13:38:04 INFO - mozdevice == 0.48 13:38:04 INFO - mozfile == 1.2 13:38:04 INFO - mozhttpd == 0.7 13:38:04 INFO - mozinfo == 0.9 13:38:04 INFO - mozleak == 0.1 13:38:04 INFO - mozlog == 3.4 13:38:04 INFO - moznetwork == 0.27 13:38:04 INFO - mozprocess == 0.23 13:38:04 INFO - mozprofile == 0.28 13:38:04 INFO - mozrunner == 6.13 13:38:04 INFO - mozscreenshot == 0.1 13:38:04 INFO - mozsystemmonitor == 0.3 13:38:04 INFO - moztest == 0.8 13:38:04 INFO - mozversion == 1.4 13:38:04 INFO - psutil == 3.1.1 13:38:04 INFO - requests == 1.2.3 13:38:04 INFO - wsgiref == 0.1.2 13:38:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:04 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')]} 13:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:04 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')]} 13:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:04 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 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:38:04 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 13:38:04 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 13:38:04 INFO - Using env: {'DISPLAY': ':0', 13:38:04 INFO - 'HOME': '/home/cltbld', 13:38:04 INFO - 'LANG': 'en_US.UTF-8', 13:38:04 INFO - 'LANGUAGE': 'en_US:en', 13:38:04 INFO - 'LOGNAME': 'cltbld', 13:38:04 INFO - 'MAIL': '/var/mail/cltbld', 13:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:04 INFO - 'MOZ_NO_REMOTE': '1', 13:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:04 INFO - 'NO_EM_RESTART': '1', 13:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:04 INFO - 'PWD': '/builds/slave/test', 13:38:04 INFO - 'SHELL': '/bin/bash', 13:38:04 INFO - 'SHLVL': '1', 13:38:04 INFO - 'TERM': 'linux', 13:38:04 INFO - 'TMOUT': '86400', 13:38:04 INFO - 'USER': 'cltbld', 13:38:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:04 INFO - '_': '/tools/buildbot/bin/python'} 13:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 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)) 13:38:05 INFO - Cleaning up... 13:38:05 INFO - Return code: 0 13:38:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f514b210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, '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': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', '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 13:38: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', 'jsonschema'] in /builds/slave/test/build 13:38: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 jsonschema 13:38:05 INFO - Using env: {'DISPLAY': ':0', 13:38:05 INFO - 'HOME': '/home/cltbld', 13:38:05 INFO - 'LANG': 'en_US.UTF-8', 13:38:05 INFO - 'LANGUAGE': 'en_US:en', 13:38:05 INFO - 'LOGNAME': 'cltbld', 13:38:05 INFO - 'MAIL': '/var/mail/cltbld', 13:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:05 INFO - 'MOZ_NO_REMOTE': '1', 13:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:05 INFO - 'NO_EM_RESTART': '1', 13:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:05 INFO - 'PWD': '/builds/slave/test', 13:38:05 INFO - 'SHELL': '/bin/bash', 13:38:05 INFO - 'SHLVL': '1', 13:38:05 INFO - 'TERM': 'linux', 13:38:05 INFO - 'TMOUT': '86400', 13:38:05 INFO - 'USER': 'cltbld', 13:38:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:05 INFO - '_': '/tools/buildbot/bin/python'} 13:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:38:05 INFO - Cleaning up... 13:38:05 INFO - Return code: 0 13:38:05 INFO - Running post-action listener: _resource_record_post_action 13:38:05 INFO - Running post-action listener: _start_resource_monitoring 13:38:05 INFO - Starting resource monitoring. 13:38:05 INFO - [mozharness: 2017-01-31 21:38:05.288109Z] Finished create-virtualenv step (success) 13:38:05 INFO - [mozharness: 2017-01-31 21:38:05.288615Z] Running install step. 13:38:05 INFO - Running pre-action listener: _resource_record_pre_action 13:38:05 INFO - Running main action method: install 13:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:38:05 INFO - Reading from file tmpfile_stdout 13:38:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:38:05 INFO - Reading from file tmpfile_stdout 13:38:05 INFO - Output received: 13:38:05 INFO - Usage: mozinstall [options] installer 13:38:05 INFO - Options: 13:38:05 INFO - -h, --help show this help message and exit 13:38:05 INFO - -d DEST, --destination=DEST 13:38:05 INFO - Directory to install application into. [default: 13:38:05 INFO - "/builds/slave/test"] 13:38:05 INFO - --app=APP Application being installed. [default: firefox] 13:38:05 INFO - mkdir: /builds/slave/test/build/application 13:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:38:19 INFO - Reading from file tmpfile_stdout 13:38:19 INFO - Output received: 13:38:19 INFO - /builds/slave/test/build/application/firefox/firefox 13:38:19 INFO - Running post-action listener: _resource_record_post_action 13:38:19 INFO - [mozharness: 2017-01-31 21:38:19.994190Z] Finished install step (success) 13:38:19 INFO - [mozharness: 2017-01-31 21:38:19.994497Z] Running run-tests step. 13:38:19 INFO - Running pre-action listener: _resource_record_pre_action 13:38:19 INFO - Running main action method: run_tests 13:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:38:20 INFO - Python 2.7.3 13:38:20 INFO - Return code: 0 13:38:20 INFO - grabbing minidump binary from tooltool 13:38:20 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')]} 13:38:20 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 0x1f91f60>, '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 0x1f92d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f931d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:38:20 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 13:38:20 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 13:38:20 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 13:38:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:38:20 INFO - Return code: 0 13:38:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:38:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:38:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:38:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:38:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:38:20 INFO - Using env: {'DISPLAY': ':0', 13:38:20 INFO - 'HOME': '/home/cltbld', 13:38:20 INFO - 'LANG': 'en_US.UTF-8', 13:38:20 INFO - 'LANGUAGE': 'en_US:en', 13:38:20 INFO - 'LOGNAME': 'cltbld', 13:38:20 INFO - 'MAIL': '/var/mail/cltbld', 13:38:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:38:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:20 INFO - 'MOZ_NO_REMOTE': '1', 13:38:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:20 INFO - 'NO_EM_RESTART': '1', 13:38:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:20 INFO - 'PWD': '/builds/slave/test', 13:38:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:38:20 INFO - 'SHELL': '/bin/bash', 13:38:20 INFO - 'SHLVL': '1', 13:38:20 INFO - 'TERM': 'linux', 13:38:20 INFO - 'TMOUT': '86400', 13:38:20 INFO - 'USER': 'cltbld', 13:38:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674', 13:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:20 INFO - '_': '/tools/buildbot/bin/python'} 13:38:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:38:20 INFO - mozversion application_buildid: 20170131114308 13:38:20 INFO - mozversion application_changeset: f271c045f7abe68f3c4e650f3901be6f32892b48 13:38:20 INFO - mozversion application_display_name: Firefox 13:38:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:38:20 INFO - mozversion application_name: Firefox 13:38:20 INFO - mozversion application_remotingname: firefox 13:38:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:38:20 INFO - mozversion application_vendor: Mozilla 13:38:20 INFO - mozversion application_version: 52.0 13:38:20 INFO - mozversion platform_buildid: 20170131114308 13:38:20 INFO - mozversion platform_changeset: f271c045f7abe68f3c4e650f3901be6f32892b48 13:38:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:38:20 INFO - mozversion platform_version: 52.0 13:38:20 INFO - using testdate: 1485898700 13:38:20 INFO - actual date: 1485898700 13:38:20 INFO - starting webserver on 'localhost:42437' 13:38:20 INFO - SUITE-START | Running 2 tests 13:38:20 INFO - TEST-START | dromaeo_css 13:38:20 INFO - operating with platform_type : linux_ 13:38:20 INFO - Initialising browser for dromaeo_css test... 13:38:20 INFO - TEST-INFO | started process 18746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq_M1Ai/profile http://localhost:42437/getInfo.html) 13:38:24 INFO - PROCESS | 18746 | __metrics Screen width/height:1600/1200 13:38:24 INFO - PROCESS | 18746 | colorDepth:24 13:38:24 INFO - PROCESS | 18746 | Browser inner width/height: 1024/697 13:38:24 INFO - PROCESS | 18746 | __metrics 13:38:25 INFO - PROCESS | 18746 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:38:25 INFO - PROCESS | 18746 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:38:25 INFO - PROCESS | 18746 | console.error: PushService: 13:38:25 INFO - PROCESS | 18746 | stateChangeProcessEnqueue: Error transitioning state 13:38:25 INFO - PROCESS | 18746 | UnknownError 13:38:26 INFO - TEST-INFO | 18746: exit 0 13:38:26 INFO - Browser initialized. 13:38:26 INFO - Running cycle 1/1 for dromaeo_css test... 13:38:26 INFO - TEST-INFO | started process 18837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq_M1Ai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:38 INFO - PROCESS | 18837 | RSS: Main: 145158144 13:38:38 INFO - PROCESS | 18837 | 13:41:39 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42437/tests/dromaeo/cssquery-ext.html) 13:41:40 INFO - PROCESS | 18837 | RSS: Main: 240939008 13:41:40 INFO - PROCESS | 18837 | 13:44:43 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-ext.html (next: http://localhost:42437/tests/dromaeo/cssquery-jquery.html) 13:44:43 INFO - PROCESS | 18837 | RSS: Main: 228978688 13:44:43 INFO - PROCESS | 18837 | 13:47:45 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42437/tests/dromaeo/cssquery-mootools.html) 13:47:45 INFO - PROCESS | 18837 | RSS: Main: 222736384 13:47:45 INFO - PROCESS | 18837 | 13:50:47 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42437/tests/dromaeo/cssquery-prototype.html) 13:50:48 INFO - PROCESS | 18837 | RSS: Main: 222896128 13:50:48 INFO - PROCESS | 18837 | 13:53:51 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42437/tests/dromaeo/cssquery-yui.html) 13:53:51 INFO - PROCESS | 18837 | RSS: Main: 176881664 13:53:51 INFO - PROCESS | 18837 | 13:56:53 INFO - PROCESS | 18837 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-yui.html (next: http://localhost:42437/tests/dromaeo/cssquery-dojo.html) 13:56:54 INFO - PROCESS | 18837 | RSS: Main: 267579392 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | __start_tp_report 13:56:54 INFO - PROCESS | 18837 | _x_x_mozilla_page_load 13:56:54 INFO - PROCESS | 18837 | _x_x_mozilla_page_load_details 13:56:54 INFO - PROCESS | 18837 | |i|pagename|runs| 13:56:54 INFO - PROCESS | 18837 | |0;dojo.html;3219.2756629758305;3239.1740106272905;3242.5622540956965;3265.102096923346;3282.524034015068;5584.441555844419;5683.573731970098;5701.287339082614;5713.285839270091;5738.913916291253;5607.831765047055;5664.433556644333;5667.716614169296;5668.971655141719;5706.99999999999;5106.540411362977;5126.92309615356;5131.692098474104;5171.405288391827;5211.817586384477;4987;5022.799088036474;5203.4796520348045;5212.76542555584;5240.135377662681;5069.239614057884;5091.567216786578;5096.490350964892;5105.361829771278;5133.101707201244;5137.922931156036;5138.7173705446185;5212.635115541913;5219.112750832368;5246.763895624668;4888.633352498541;5101.132807422747;5108.2593024011685;5163.3545806774155;5181.5854731621375;5471.316085489314;5480.369757477902;5494.395616482184;5543.417941116165;5547.195656629766;5938.10928360745;5946.197263369476;5958.13607026983;6019.518438524908;6024.879502409927;6056.576039677225;6071.332153463116;6073.4837538808815;6081.239845019372;6089.0866370044405;5541.667499950016;5576.888462230773;5581.581381396411;5621.15682647598;5629.43705629442;6148.262208535004;6167.290761562478;6173.41352571505;6175.475084617858;6187.504999600022;5885.735141918538;5887.1463637772285;5895.823125306248;5897.49871260939;5912.526997840162;5814.76740930358;5867.882642347215;5942.168096466498;6020;6028.095785632103;6048.576599637983;6053.939460605337;6055.576109672369;6058.1215723719815;6068.059450785136;6060.727267272983;6062.030075187949;6078.179445774852;6079.331273559905;6086.178365920544;4532.478764942074;4564.680472366969;4591.79336929839;4619.330197121399;4669.906601868011;4097.549269580344;4127.938080928789;4145.274576949022;4148.668106551469;4152.709310348247;5698.088305871041;5698.7435565399655;5729.742161602738;5750.6837123958585;5767.250257466587;5833;5880.206172166702;5973.163757074013;6034.456898879122;6055.152278680988;5668.744906479218;5755.625884317506;5755.827325180251;5773.884522309614;5787.160861675034;5001.549860512571;5010.749462526859;5012.448630650625;5013.849584512471;5049.469805670352;6146.4468197861515;6191.97832357674;6281.466075383552;6329.367063293634;6348.428641422294;5949.732262048132;5981.431763982415;6029.9698501508965;6061.515078793774;6106.786262480792;6292.842678933063;6325.367463253638;6328.208973878265;6332.11350410952;6335;5758.222639943721;5969.432903874125;5983.850403739767;5988.431099045583;6000.849978750566;5825.097109947796;6009.609375390585;6066.878662426815;6074.817755467343;6131.988406491147;5915.260592425947;5967.731452084579;5968.582199246011;5977.551683623658;5980.282366116094;5956.255468066492;5980.491658209101;5981.162637230878;5987.461128498282;5988.431099045583;5583.944160558342;5776.451237132465;5815.011448053926;5856.150858125633;5874.5887787854435;5977.551683623833;5979;5981.611195272293;5983.162357270073;5993.280806303272;5666.773329066791;5684.886302273849;5823.505002074871;5825.126231065374;5837.387074357302 13:56:54 INFO - PROCESS | 18837 | |1;ext.html;575.7236526467295;612.8866159760444;643.9098526206332;648.5492582655054;650.8340373204832;35530;38318.23363532731;46519.30221046683;47398.52601473993;47539.76230118853;48179.27731084036;48577.75711121439;48741;48810.26784598234;48811.75594122033;8997.46015239086;9089.863652045224;9160.45037297761;9171.403858749194;9172.54137293136;8471.32229421648;8738.86891696625;9055.95472022639;10765.515551800188;11040.392778397185;11130.109591232722;11166.385848778315;11213.383263920481;11213.887861121406;11220.270682405659;10784.245102842804;10794.946025269903;10819.404932728698;10825.188110891715;10837.945810270898;8434.57827108642;8708.564571771387;10595.311304765242;10947.781044379068;10966.561337546489;45246;45662.086758264646;45676;45716.31425528586;45745.77127114343;3701.0747313171705;3707.4253490708984;3717.5910649828497;3788.6796198416887;4221.409002739619;33212.346612040245;33686.1578460538;33921;34765.13087172816;35266;4373.365861950031;4453.821847126111;4460.955390446086;4491.955080449186;4499.167653983991;330477;332427;333449;333486;335759;63583.68208158929;63799.68100159562;63806.36193638097;63880.36119638744;63930.36069639244;68618;68658;68694.65652671705;68735.31264687389;68842.31157688459;16171.110588917487;16471.752923706154;16474.341026359052;16474.505764827074;16475;11383.203175777617;13323.733525329439;13341.399637016164;13363.532276370475;13434.126781759154;17220.569485762957;19321.51696207606;19455.09065273945;20259.493512662302;20441.182352706022;6490;6552.6068435894;6581.638009909501;6669.899951500732;6687.264400915896;978.0512902484578;1047.7642530430592;1050.9632162874263;1085.685151306128;1121.556984990924;33640.327193455996;33685.83157084199;33900.66099338975;33939.66060339414;34349;1181.1377694283221;1194.062660811259;1224.8162775583735;1226.5645695778048;1237.3442075699893;17761.644767104586;17940.730889036677;18038.90980545089;18048.187831547613;18158;499004;501738;503720;504196;505038;63258.36741632617;63337.68331158407;63475.682621586595;63512.36487635157;63536.68231658812;1275.515304184404;1335.2922950835878;1355.966100847467;1369.575431616222;1434.8278206615273;29956.101316959655;35000.29999400049;35071.29857402787;35220;35399.64600353964;52241.47758522366;52832.20751688651;52941;52945.7352713234;52954.2056869155;376333;380904;380931;381754;382920;36683.81658091799;37051.8147409272;38122.237555249296;41243.587564123976;46588.53411465842;48050;49200.50799491959;49379.25931110964;49508.50491495039;49782;41541.79229103835;41702.582974171084;42267.57732422637;43147;43907.560924390345;41107.383389248585;41278;41844.79077604593;43058.78470607627;43086;42111.7894410526;42794.14411711811;43677.12645747004;43851.342229867216;43869.561304386545;35788.28423431569;37360.81319593385;38012.80993595014;38149.23701526009;38335;28312.85843570769;28624.71002319851;28719.569206461503;29025.564616531192;29049.7095029047 13:56:54 INFO - PROCESS | 18837 | |2;jquery.html;414.264680192658;417.83286685325845;428.5478819845063;430.7458599426339;445.3853681918951;18741.62516749664;18832.52918677032;20594.38216853497;20611.484712882168;20741.170353185855;19684.409467715956;19954.501137471536;20144.194232230693;20672.586548269024;20764.27325043624;5859.238299021121;6114.785982490614;6131.202943617323;6133.355997620252;6140.969295153518;5880.088586269114;5986.8503287417725;6012.789552365668;6022.096685497188;6126.417990290915;5924.0521516557355;5942.5840191186635;5949.762009519614;5951.137085122655;5982.910256346158;5758.827235182951;5937.406259374071;5960.612560183596;5989.341172471025;5999.430054144849;5440.183972404131;5440.863978400532;5446.2375267462585;5451.155070964007;5451.3458384993655;23750.881245593835;23832.76167238323;24075;24077.157299494607;24500.877495612407;2462.5444292805887;2581.3675649465813;2663.6537250157357;2687.6640419947507;2762.8342299462097;10841.295315804447;15331.846681533265;15423.383064677511;15426.614334641723;15459.227038648023;2005.037581960667;2070.3892351756117;2086.1029757204396;2112.155137944819;2114;86102.13897861003;90848;90900.54549727275;92641;93358;11927.403629818475;12008.339541325311;12095.21381110225;12156.270623762603;12352.691182720504;17130.828691713174;17136;17147.57131071708;17152.399666011628;17171.227294771765;8279.213474719892;8412.915870841212;8624.611892464854;8632.309415246766;8800.955995219983;7758.728444504415;7901.881471777928;8261.297789687824;8494.660213591511;8495.405321627426;5133.486651334837;5178.990096931062;5186.844394668166;5224.085784987688;5315.867103322448;2101.947451313699;2160.1143531152466;2174.1629472652826;2174.510735084625;2185.726784151981;915.3592485260211;965.9471176417738;974.5663179885025;1015.2284263959444;1053.7365658585354;20260.594788104154;20350.694739578918;20422.08100635475;20461.693074603892;20802.895985519976;966.5215718219386;997.3915911294105;1009.1069403577886;1038.1746511523356;1049.8162821506205;10652.254342196127;11365.261258018203;11424.975527898203;11741.4716337765;11823.408829558659;476672;479511;480259;500113;502598;92770.53614731884;93209;93721;95353.52323238339;95931.52034239784;962.8651988721584;977.5503268496429;990.3562684255292;994.7165057958447;995.5072239241622;17729;17765.733513997042;18489;18502.907485462485;18518;43138.13723725571;43429.78285108554;43460.348094779234;43626.56373436225;44340.11319773651;53937.460625394815;57147.714261428424;57875;58568.414315858;58732.41267587269;8208.876866846882;8403.285720713564;8961.551922403984;9000.144986226298;9424.764380890532;9765.804683906425;13705.314734263446;13894.166350019032;14336.354864030935;14457.421703131757;11730.237534560227;11987.64037078889;12074.879251207376;12702.491900323883;12836.101472896808;12206.694832629255;12214.08394370408;12222.266664000188;12235.32705701195;12711.55509557161;12638.873611264138;12650.683732906751;12672.556460523838;12862.421191046613;12982.35088245565;8524.403291769517;8644.005939316807;8796.340274479311;8799.47203167812;8810.383273170817;11315.660530184108;12193.69515762113;12257.632271031884;12475.500979961063;12699.809502857279 13:56:54 INFO - PROCESS | 18837 | |3;mootools.html;1344.7579435701582;1494.5217530390273;1533.5935976966102;1662.5843539115222;1789.1839782620643;8062.435629505937;8798;9088.136627020422;9096.0449152839;9306;9121.863172052408;9183.632654693803;9185.724428267162;9201.079892010795;9216.447013179213;2510.548101341758;2532.5441420544294;2540.415704387992;2540.8602526861014;2552.0429838810446;2492.3519884829893;2597.2727636261784;2613.1376645706964;2613.255222261656;2617.8952841886303;2517.25740906433;2532.278300684305;2581.1095172165574;2588.9902937854254;2593.610958356243;2493.9750602494014;2512.472380800034;2532.962005569918;2549.4518678484214;2550.4134049168797;2482.962755558668;2491.813114016456;2514.9311542594323;2517.9118730844516;2533.936651583707;8993.460392376479;9078.818423631556;9096.63613455461;9164.6792362267;9176.81646367069;5609.551235901118;5821.155932389822;5856.267966504187;5857.238558987305;5858.677772722499;3483.198864261234;3606.296772129436;3622.3841946869097;3687.2441149564274;3689.9889560189763;1216.1669256559285;1226.693326668333;1236.969075773104;1282.1089342906685;1315.83552055993;12804.551840685532;12860;12927.418266178045;12934.48262069516;12934.805977910339;4728.290756386501;4929.654924155347;4958.082754690394;4981.526754958273;5041.294218809369;10234.846477302846;10241.692749217535;10248.538815753309;10251.179905607534;10253.794924101476;5719.542436605062;5720;5728.1407788831175;5734.741936612862;5737.569682273846;4440.4227450431235;4674.929876051862;4728.290756386501;5180.81867134656;5286.656367336111;4138.1585194588115;4182.456280683492;4224.155168966219;4252.468441444819;4283.807228674717;1300.0639539531521;1323.3184909771476;1324.6754545136503;1336.3719052045524;1338.3642769684323;881.6341218394423;1032.6643840751785;1037.419045334615;1045.639254457211;1048.4286064095086;5962.850928726816;5982.192404025401;6071.574989750675;6174.166487524217;6244.687765611792;486.7809485731364;505.507130547713;507.959363250939;513.7842106315281;1023.1967905194387;4128;4249.6387807036745;4272.914541709149;4346.935000924794;4374.12517496502;11259.831102533468;11498.02266807314;11583.189176757714;11610.535578576932;11631.418429078512;11545.36500492481;11549.595764148215;11549.826752598718;11561.653150405502;11571.30572165656;8585.828283434297;8631.6978905738;8711.825763484821;8810.163034511712;8810.911890881138;6065.848353791191;6102.511799056154;6122.357152498924;6184.412480814315;6193.907091393723;10251.794964100825;10467.267291289536;10478.947605261925;10565.418901960466;10581.4709264538;9450.43297402158;9755.609775608897;10217.233707472118;10639.255252132276;10640.308379955279;7448.5158464699625;7745.845083098419;7769.689212431439;7823.374130069467;7831.707768218408;8717.346199034972;8784.78038049054;8788.824223515621;8794.384393092421;8797.428167169113;7668.463207575416;7788.104367997526;7899.763007109796;7984.24149705777;8041.356691464785;7687.692492300245;7715.961420193088;7762.805929851799;7772.45592808498;7781.105172905189;7121.181064177686;7139.785806425815;7191.820204494929;7312.670929808278;7391.7434036215045;5161.948380516297;5336.012837625051;5340.706261155674;5345.1714984177515;5388.38033626138;5281.471852814688;5461.590380721383;5508.394076651645;5528.143137813645;5690.146478028329 13:56:54 INFO - PROCESS | 18837 | |4;prototype.html;330.6941079501461;332.02384988134884;335.34272825262485;348.90405138586885;350.508931046774;5356.330458692663;5518.1998610201545;5519.889602207953;5531.3915469298445;5618.4662457066515;5446.373667028293;5463.48096930791;5477.3427188737305;5485.780568777244;5503.394626591072;4313.396124542566;4322.351647252914;4332.696711230215;4341.50072741634;4373.343998400233;3807.3527500325013;4109.486314210723;4197.454330936974;4305.763183024932;4327.0913108247305;4259.2546304396765;4262.211490874182;4267.359896015607;4275.7434553926705;4281.614654681078;4281.978590107061;4290.4851417829905;4293.914121717564;4303.160883627694;4303.526612072669;3651.8721844735574;3779.4897688811934;3824.7896365699876;3825.3496905526126;3836.5396152461603;5265.97313523863;5274.393444753864;5284.603654725911;5295.735213239323;5303.337082864642;4899.853004409873;4905.509449055102;4908.870959679258;4921.458639549683;4924.556789888891;5597.272354593917;5633.070543360341;5664.461876121762;5715.885682286331;5731.426857314277;4151.8546850860375;4154.003039270584;4155.148194620096;4157.750534967911;4177.832886684529;5574.163875418679;5753.971230143822;5881.6471011739;5911.674857882815;5920.822375328747;4121.928298642375;4200.91598168041;4206.978965105155;4218.873433796991;4223.640990515779;4270.807813648394;4273.658107351404;4278.058827058042;4297.548757380492;4323.891902702458;4756.405449318835;4818.855434336975;4887.437944636341;4917.139500587383;4932.753362331869;5650.898074875442;5668.404817494186;5695.430456954355;5695.45893140151;5724.16999535065;1411.2167746900363;1418.5673369622364;1423.3879431844407;1426.9500567480088;1432.6633241188313;957.5923392612987;997.3666721631816;1005.0351662404174;1009.7728011197422;1011.3123076308034;5262.894742105136;5288.68267903927;5294.205869119663;5318.414974352818;5319.787208511616;5542.473465020817;5553.444655534414;5558.499735023867;5579.860503487445;5594.664320140804;5082.313887625197;5250.947490525123;5282.418933917266;5301.602379821529;5314.92027619586;2943.45546073977;2951.099914526047;2955.2907302247304;2980.5231163013814;2987.6116104906223;5763.2507773989955;5790.826275211751;5829.5044921181325;5835.328937172195;5864.413558644102;5686.4646545433325;6003.669798161056;6006.2191915051635;6018.909716354258;6020.608660437058;6125.816225513242;6130.63216207029;6131.172291740558;6135.5398345124295;6187.133801267826;5566.888662226814;5755.769769209185;5775.364709881826;5847.473727364558;5892.705364731661;5780.2485676863425;5782.212650713789;5793.884122317614;5833.883322333614;5849.824505264849;5874.089516125007;5901.940980590311;5944.8811023780145;6054.455099041107;6101.908471372844;4237.470316210473;4247.87256382309;4257.403963445058;4275.273203555341;4278.117628243563;5699.803041361361;5904.586678932434;5928.170056192051;5932.080527518242;5933.139694744152;5662.773489060556;5666.688332141772;5687.203791469115;5691.203231547669;5714.857128571819;5692.975264452439;5701.173329867063;5707.914381284367;5737.225474560881;5746.770129194785;5508.338999320107;5668.712146954674;5701.828945131652;5703.714814259353;5730.71346432685;5717.656940583578;5717.685527296038;5728.169415434655;5730.398308177581;5734.111212762028;5575.498205161555;5596.216529685928;5607.158926161109;5620.4660557247;5632.295963004624 13:56:54 INFO - PROCESS | 18837 | |5;yui.html;791.8891355210271;798.7084714079363;819.4468733604815;834.4867906237664;915.1534830281987;14738.410463581456;15783.210839458025;16064.27710753016;16236.107014114219;16340.509784706448;13842;13843.030987830856;13967.720645587082;14102.36539355729;14215.360308786103;729.8613263479948;836.8200836820098;850.2347886901807;850.5279569838737;851.1913682002091;731.144560863788;858.9785255368603;871.485823364215;876.119499902597;876.5135349880813;891.8394688955985;898.5597057441872;903.1555495611591;903.7695387676133;904.0326850270213;900.2572877376191;900.5632268349846;900.779309069279;901.4230892228978;902.5442151713409;661.3849120318102;661.7915356662684;661.9768308109193;662.4766434516725;662.8342914271432;14501.27493625325;14808.851911480855;14818;14861.777073343908;15048.097114173075;14894.329755161043;15343;15617.687646247125;15676.921615391964;15745.527634170992;11740.236884602473;11909.642710718692;11968.640940771791;12048.397580121047;12141.392930353448;4493.146302202571;4495.033567782943;4529.388532548097;4553.658475614309;4743.573078422958;63011.05483417798;63022;63210.36789632137;64575;64936.3506364935;11549.249298795552;11599.188056836108;11621.593244236412;11637.359945202927;11750.647480575426;20154.899225503777;20161.092750826247;20220.39338819838;20249.08879100444;20311.59376812485;8159;8167.509949403055;8426.915730842737;8432.789180270542;8540.786480338042;4566.383538222298;4607.170709272363;4750.596199323028;4807.423109226916;4834.758262086882;3592.497050412944;3755.849766009329;3762.0406796266775;3765.171662234304;3765.981170094132;624.356912380249;634.4004915354946;648.8377905523619;652.0935899100255;657.8782925158861;576.5992635118553;649.2176926803285;695.7912626212116;707.4189187166678;715.9319864612853;8970.641174352953;9232.122948319899;9249;9331.393459425115;9433.575489103006;672.6838385958591;672.862063277027;675.0481820632884;676.1210426445699;685.4550632247375;4232.703710740218;4363.432753741993;4390.1878152541885;4392.253316936129;4448.55514448559;91873.0812691878;91879;92189.53905230566;93066;95717.5214123925;49140;64129.35870641234;73492;79855.60072199602;83117.16882831094;65359.67320163369;66690;67482.3251767476;67783.98324025143;68582.97125543121;9912.903564308042;9935.900640993497;10052.132466114013;10349.63776267827;10375.792484150426;39053.80473097616;39127.60872391354;41352.79323603363;41714.37428438515;43673.78163109164;39941.40087898626;41996.95007624834;42346;56506.71746641405;62923.6853815728;12479.438425271066;12613.432395542406;12883.48466061347;12975.935120324339;13053.738925221252;14279.429262781294;14463.49377771773;14495.275236237934;14775.92612036933;14932.701345973237;13777.586672399844;13880.375383107987;14194;14398.42406303778;15189.6202594936;12503.56237531682;12734.68163295925;13297.933510332387;13361.866381336062;13688.52090176839;13005.804912926125;13245.602631921058;13283.734325313633;13547.59357219285;14216.289185540889;11441.48513316886;11579.42102894835;11674.649760507198;11975.401229938643;12231.69420764488;11493.48279327449;11787.587434440096;11847.822282665938;11900.702482438008;12098.818517722066 13:56:54 INFO - PROCESS | 18837 | __end_tp_report 13:56:54 INFO - PROCESS | 18837 | __start_cc_report 13:56:54 INFO - PROCESS | 18837 | _x_x_mozilla_cycle_collect,1009 13:56:54 INFO - PROCESS | 18837 | __end_cc_report 13:56:54 INFO - PROCESS | 18837 | __startTimestamp1485899814209__endTimestamp 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | ------- Summary: start ------- 13:56:54 INFO - PROCESS | 18837 | Number of tests: 6 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | [#0] dojo.html Cycles:165 Average:5598.83 Median:5823.51 stddev:644.96 (11.1%) stddev-sans-first:619.33 13:56:54 INFO - PROCESS | 18837 | Values: 3219.3 3239.2 3242.6 3265.1 3282.5 5584.4 5683.6 5701.3 5713.3 5738.9 5607.8 5664.4 5667.7 5669.0 5707.0 5106.5 5126.9 5131.7 5171.4 5211.8 4987.0 5022.8 5203.5 5212.8 5240.1 5069.2 5091.6 5096.5 5105.4 5133.1 5137.9 5138.7 5212.6 5219.1 5246.8 4888.6 5101.1 5108.3 5163.4 5181.6 5471.3 5480.4 5494.4 5543.4 5547.2 5938.1 5946.2 5958.1 6019.5 6024.9 6056.6 6071.3 6073.5 6081.2 6089.1 5541.7 5576.9 5581.6 5621.2 5629.4 6148.3 6167.3 6173.4 6175.5 6187.5 5885.7 5887.1 5895.8 5897.5 5912.5 5814.8 5867.9 5942.2 6020.0 6028.1 6048.6 6053.9 6055.6 6058.1 6068.1 6060.7 6062.0 6078.2 6079.3 6086.2 4532.5 4564.7 4591.8 4619.3 4669.9 4097.5 4127.9 4145.3 4148.7 4152.7 5698.1 5698.7 5729.7 5750.7 5767.3 5833.0 5880.2 5973.2 6034.5 6055.2 5668.7 5755.6 5755.8 5773.9 5787.2 5001.5 5010.7 5012.4 5013.8 5049.5 6146.4 6192.0 6281.5 6329.4 6348.4 5949.7 5981.4 6030.0 6061.5 6106.8 6292.8 6325.4 6328.2 6332.1 6335.0 5758.2 5969.4 5983.9 5988.4 6000.8 5825.1 6009.6 6066.9 6074.8 6132.0 5915.3 5967.7 5968.6 5977.6 5980.3 5956.3 5980.5 5981.2 5987.5 5988.4 5583.9 5776.5 5815.0 5856.2 5874.6 5977.6 5979.0 5981.6 5983.2 5993.3 5666.8 5684.9 5823.5 5825.1 5837.4 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | [#1] ext.html Cycles:180 Average:59010.93 Median:210619.12 stddev:108579.40 (51.6%) stddev-sans-first:108795.35 13:56:54 INFO - PROCESS | 18837 | Values: 575.7 612.9 643.9 648.5 650.8 35530.0 38318.2 46519.3 47398.5 47539.8 48179.3 48577.8 48741.0 48810.3 48811.8 8997.5 9089.9 9160.5 9171.4 9172.5 8471.3 8738.9 9056.0 10765.5 11040.4 11130.1 11166.4 11213.4 11213.9 11220.3 10784.2 10794.9 10819.4 10825.2 10837.9 8434.6 8708.6 10595.3 10947.8 10966.6 45246.0 45662.1 45676.0 45716.3 45745.8 3701.1 3707.4 3717.6 3788.7 4221.4 33212.3 33686.2 33921.0 34765.1 35266.0 4373.4 4453.8 4461.0 4492.0 4499.2 330477.0 332427.0 333449.0 333486.0 335759.0 63583.7 63799.7 63806.4 63880.4 63930.4 68618.0 68658.0 68694.7 68735.3 68842.3 16171.1 16471.8 16474.3 16474.5 16475.0 11383.2 13323.7 13341.4 13363.5 13434.1 17220.6 19321.5 19455.1 20259.5 20441.2 6490.0 6552.6 6581.6 6669.9 6687.3 978.1 1047.8 1051.0 1085.7 1121.6 33640.3 33685.8 33900.7 33939.7 34349.0 1181.1 1194.1 1224.8 1226.6 1237.3 17761.6 17940.7 18038.9 18048.2 18158.0 499004.0 501738.0 503720.0 504196.0 505038.0 63258.4 63337.7 63475.7 63512.4 63536.7 1275.5 1335.3 1356.0 1369.6 1434.8 29956.1 35000.3 35071.3 35220.0 35399.6 52241.5 52832.2 52941.0 52945.7 52954.2 376333.0 380904.0 380931.0 381754.0 382920.0 36683.8 37051.8 38122.2 41243.6 46588.5 48050.0 49200.5 49379.3 49508.5 49782.0 41541.8 41702.6 42267.6 43147.0 43907.6 41107.4 41278.0 41844.8 43058.8 43086.0 42111.8 42794.1 43677.1 43851.3 43869.6 35788.3 37360.8 38012.8 38149.2 38335.0 28312.9 28624.7 28719.6 29025.6 29049.7 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | [#2] jquery.html Cycles:180 Average:29821.20 Median:423.19 stddev:80607.85 (19047.7%) stddev-sans-first:80803.73 13:56:54 INFO - PROCESS | 18837 | Values: 414.3 417.8 428.5 430.7 445.4 18741.6 18832.5 20594.4 20611.5 20741.2 19684.4 19954.5 20144.2 20672.6 20764.3 5859.2 6114.8 6131.2 6133.4 6141.0 5880.1 5986.9 6012.8 6022.1 6126.4 5924.1 5942.6 5949.8 5951.1 5982.9 5758.8 5937.4 5960.6 5989.3 5999.4 5440.2 5440.9 5446.2 5451.2 5451.3 23750.9 23832.8 24075.0 24077.2 24500.9 2462.5 2581.4 2663.7 2687.7 2762.8 10841.3 15331.8 15423.4 15426.6 15459.2 2005.0 2070.4 2086.1 2112.2 2114.0 86102.1 90848.0 90900.5 92641.0 93358.0 11927.4 12008.3 12095.2 12156.3 12352.7 17130.8 17136.0 17147.6 17152.4 17171.2 8279.2 8412.9 8624.6 8632.3 8801.0 7758.7 7901.9 8261.3 8494.7 8495.4 5133.5 5179.0 5186.8 5224.1 5315.9 2101.9 2160.1 2174.2 2174.5 2185.7 915.4 965.9 974.6 1015.2 1053.7 20260.6 20350.7 20422.1 20461.7 20802.9 966.5 997.4 1009.1 1038.2 1049.8 10652.3 11365.3 11425.0 11741.5 11823.4 476672.0 479511.0 480259.0 500113.0 502598.0 92770.5 93209.0 93721.0 95353.5 95931.5 962.9 977.6 990.4 994.7 995.5 17729.0 17765.7 18489.0 18502.9 18518.0 43138.1 43429.8 43460.3 43626.6 44340.1 53937.5 57147.7 57875.0 58568.4 58732.4 8208.9 8403.3 8961.6 9000.1 9424.8 9765.8 13705.3 13894.2 14336.4 14457.4 11730.2 11987.6 12074.9 12702.5 12836.1 12206.7 12214.1 12222.3 12235.3 12711.6 12638.9 12650.7 12672.6 12862.4 12982.4 8524.4 8644.0 8796.3 8799.5 8810.4 11315.7 12193.7 12257.6 12475.5 12699.8 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | [#3] mootools.html Cycles:180 Average:6027.08 Median:4728.29 stddev:3391.01 (71.7%) stddev-sans-first:3382.27 13:56:54 INFO - PROCESS | 18837 | Values: 1344.8 1494.5 1533.6 1662.6 1789.2 8062.4 8798.0 9088.1 9096.0 9306.0 9121.9 9183.6 9185.7 9201.1 9216.4 2510.5 2532.5 2540.4 2540.9 2552.0 2492.4 2597.3 2613.1 2613.3 2617.9 2517.3 2532.3 2581.1 2589.0 2593.6 2494.0 2512.5 2533.0 2549.5 2550.4 2483.0 2491.8 2514.9 2517.9 2533.9 8993.5 9078.8 9096.6 9164.7 9176.8 5609.6 5821.2 5856.3 5857.2 5858.7 3483.2 3606.3 3622.4 3687.2 3690.0 1216.2 1226.7 1237.0 1282.1 1315.8 12804.6 12860.0 12927.4 12934.5 12934.8 4728.3 4929.7 4958.1 4981.5 5041.3 10234.8 10241.7 10248.5 10251.2 10253.8 5719.5 5720.0 5728.1 5734.7 5737.6 4440.4 4674.9 4728.3 5180.8 5286.7 4138.2 4182.5 4224.2 4252.5 4283.8 1300.1 1323.3 1324.7 1336.4 1338.4 881.6 1032.7 1037.4 1045.6 1048.4 5962.9 5982.2 6071.6 6174.2 6244.7 486.8 505.5 508.0 513.8 1023.2 4128.0 4249.6 4272.9 4346.9 4374.1 11259.8 11498.0 11583.2 11610.5 11631.4 11545.4 11549.6 11549.8 11561.7 11571.3 8585.8 8631.7 8711.8 8810.2 8810.9 6065.8 6102.5 6122.4 6184.4 6193.9 10251.8 10467.3 10478.9 10565.4 10581.5 9450.4 9755.6 10217.2 10639.3 10640.3 7448.5 7745.8 7769.7 7823.4 7831.7 8717.3 8784.8 8788.8 8794.4 8797.4 7668.5 7788.1 7899.8 7984.2 8041.4 7687.7 7716.0 7762.8 7772.5 7781.1 7121.2 7139.8 7191.8 7312.7 7391.7 5161.9 5336.0 5340.7 5345.2 5388.4 5281.5 5461.6 5508.4 5528.1 5690.1 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | [#4] prototype.html Cycles:180 Average:4791.84 Median:5470.41 stddev:1399.78 (25.6%) stddev-sans-first:1363.07 13:56:54 INFO - PROCESS | 18837 | Values: 330.7 332.0 335.3 348.9 350.5 5356.3 5518.2 5519.9 5531.4 5618.5 5446.4 5463.5 5477.3 5485.8 5503.4 4313.4 4322.4 4332.7 4341.5 4373.3 3807.4 4109.5 4197.5 4305.8 4327.1 4259.3 4262.2 4267.4 4275.7 4281.6 4282.0 4290.5 4293.9 4303.2 4303.5 3651.9 3779.5 3824.8 3825.3 3836.5 5266.0 5274.4 5284.6 5295.7 5303.3 4899.9 4905.5 4908.9 4921.5 4924.6 5597.3 5633.1 5664.5 5715.9 5731.4 4151.9 4154.0 4155.1 4157.8 4177.8 5574.2 5754.0 5881.6 5911.7 5920.8 4121.9 4200.9 4207.0 4218.9 4223.6 4270.8 4273.7 4278.1 4297.5 4323.9 4756.4 4818.9 4887.4 4917.1 4932.8 5650.9 5668.4 5695.4 5695.5 5724.2 1411.2 1418.6 1423.4 1427.0 1432.7 957.6 997.4 1005.0 1009.8 1011.3 5262.9 5288.7 5294.2 5318.4 5319.8 5542.5 5553.4 5558.5 5579.9 5594.7 5082.3 5250.9 5282.4 5301.6 5314.9 2943.5 2951.1 2955.3 2980.5 2987.6 5763.3 5790.8 5829.5 5835.3 5864.4 5686.5 6003.7 6006.2 6018.9 6020.6 6125.8 6130.6 6131.2 6135.5 6187.1 5566.9 5755.8 5775.4 5847.5 5892.7 5780.2 5782.2 5793.9 5833.9 5849.8 5874.1 5901.9 5944.9 6054.5 6101.9 4237.5 4247.9 4257.4 4275.3 4278.1 5699.8 5904.6 5928.2 5932.1 5933.1 5662.8 5666.7 5687.2 5691.2 5714.9 5693.0 5701.2 5707.9 5737.2 5746.8 5508.3 5668.7 5701.8 5703.7 5730.7 5717.7 5717.7 5728.2 5730.4 5734.1 5575.5 5596.2 5607.2 5620.5 5632.3 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - PROCESS | 18837 | [#5] yui.html Cycles:180 Average:17537.48 Median:4470.85 stddev:22719.65 (508.2%) stddev-sans-first:22748.59 13:56:54 INFO - PROCESS | 18837 | Values: 791.9 798.7 819.4 834.5 915.2 14738.4 15783.2 16064.3 16236.1 16340.5 13842.0 13843.0 13967.7 14102.4 14215.4 729.9 836.8 850.2 850.5 851.2 731.1 859.0 871.5 876.1 876.5 891.8 898.6 903.2 903.8 904.0 900.3 900.6 900.8 901.4 902.5 661.4 661.8 662.0 662.5 662.8 14501.3 14808.9 14818.0 14861.8 15048.1 14894.3 15343.0 15617.7 15676.9 15745.5 11740.2 11909.6 11968.6 12048.4 12141.4 4493.1 4495.0 4529.4 4553.7 4743.6 63011.1 63022.0 63210.4 64575.0 64936.4 11549.2 11599.2 11621.6 11637.4 11750.6 20154.9 20161.1 20220.4 20249.1 20311.6 8159.0 8167.5 8426.9 8432.8 8540.8 4566.4 4607.2 4750.6 4807.4 4834.8 3592.5 3755.8 3762.0 3765.2 3766.0 624.4 634.4 648.8 652.1 657.9 576.6 649.2 695.8 707.4 715.9 8970.6 9232.1 9249.0 9331.4 9433.6 672.7 672.9 675.0 676.1 685.5 4232.7 4363.4 4390.2 4392.3 4448.6 91873.1 91879.0 92189.5 93066.0 95717.5 49140.0 64129.4 73492.0 79855.6 83117.2 65359.7 66690.0 67482.3 67784.0 68583.0 9912.9 9935.9 10052.1 10349.6 10375.8 39053.8 39127.6 41352.8 41714.4 43673.8 39941.4 41997.0 42346.0 56506.7 62923.7 12479.4 12613.4 12883.5 12975.9 13053.7 14279.4 14463.5 14495.3 14775.9 14932.7 13777.6 13880.4 14194.0 14398.4 15189.6 12503.6 12734.7 13297.9 13361.9 13688.5 13005.8 13245.6 13283.7 13547.6 14216.3 11441.5 11579.4 11674.6 11975.4 12231.7 11493.5 11787.6 11847.8 11900.7 12098.8 13:56:54 INFO - PROCESS | 18837 | -------- Summary: end -------- 13:56:54 INFO - PROCESS | 18837 | 13:56:54 INFO - TEST-INFO | 18837: exit 0 13:56:54 INFO - TEST-OK | dromaeo_css | took 1114648ms 13:56:54 INFO - TEST-START | kraken 13:56:54 INFO - operating with platform_type : linux_ 13:56:54 INFO - Initialising browser for kraken test... 13:56:54 INFO - TEST-INFO | started process 19140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMtMijq/profile http://localhost:42437/getInfo.html) 13:56:59 INFO - PROCESS | 19140 | __metrics Screen width/height:1600/1200 13:56:59 INFO - PROCESS | 19140 | colorDepth:24 13:56:59 INFO - PROCESS | 19140 | Browser inner width/height: 1024/697 13:56:59 INFO - PROCESS | 19140 | __metrics 13:56:59 INFO - PROCESS | 19140 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:56:59 INFO - PROCESS | 19140 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:57:00 INFO - PROCESS | 19140 | console.error: PushService: 13:57:00 INFO - PROCESS | 19140 | stateChangeProcessEnqueue: Error transitioning state 13:57:00 INFO - PROCESS | 19140 | UnknownError 13:57:00 INFO - TEST-INFO | 19140: exit 0 13:57:00 INFO - Browser initialized. 13:57:00 INFO - Running cycle 1/1 for kraken test... 13:57:00 INFO - TEST-INFO | started process 19233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMtMijq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:12 INFO - PROCESS | 19233 | RSS: Main: 141889536 13:57:12 INFO - PROCESS | 19233 | 13:57:15 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-beat-detection) 13:57:16 INFO - PROCESS | 19233 | RSS: Main: 183324672 13:57:16 INFO - PROCESS | 19233 | 13:57:18 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-dft) 13:57:19 INFO - PROCESS | 19233 | RSS: Main: 173527040 13:57:19 INFO - PROCESS | 19233 | 13:57:21 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-fft) 13:57:22 INFO - PROCESS | 19233 | RSS: Main: 264269824 13:57:22 INFO - PROCESS | 19233 | 13:57:24 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-oscillator) 13:57:25 INFO - PROCESS | 19233 | RSS: Main: 171253760 13:57:25 INFO - PROCESS | 19233 | 13:57:27 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:57:27 INFO - PROCESS | 19233 | RSS: Main: 173903872 13:57:27 INFO - PROCESS | 19233 | 13:57:30 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42437/tests/kraken/driver.html?testName=imaging-darkroom) 13:57:31 INFO - PROCESS | 19233 | RSS: Main: 212221952 13:57:31 INFO - PROCESS | 19233 | 13:57:34 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42437/tests/kraken/driver.html?testName=imaging-desaturate) 13:57:35 INFO - PROCESS | 19233 | RSS: Main: 210853888 13:57:35 INFO - PROCESS | 19233 | 13:57:37 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42437/tests/kraken/driver.html?testName=json-parse-financial) 13:57:38 INFO - PROCESS | 19233 | RSS: Main: 209690624 13:57:38 INFO - PROCESS | 19233 | 13:57:40 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:57:40 INFO - PROCESS | 19233 | RSS: Main: 171773952 13:57:40 INFO - PROCESS | 19233 | 13:57:42 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:57:42 INFO - PROCESS | 19233 | RSS: Main: 179118080 13:57:42 INFO - PROCESS | 19233 | 13:57:44 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:57:45 INFO - PROCESS | 19233 | RSS: Main: 188297216 13:57:45 INFO - PROCESS | 19233 | 13:57:48 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:57:48 INFO - PROCESS | 19233 | RSS: Main: 197279744 13:57:48 INFO - PROCESS | 19233 | 13:57:51 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:57:51 INFO - PROCESS | 19233 | RSS: Main: 192786432 13:57:51 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42437/tests/kraken/driver.html?testName=ai-astar) 13:57:53 INFO - PROCESS | 19233 | RSS: Main: 245157888 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | __start_tp_report 13:57:53 INFO - PROCESS | 19233 | _x_x_mozilla_page_load 13:57:53 INFO - PROCESS | 19233 | _x_x_mozilla_page_load_details 13:57:53 INFO - PROCESS | 19233 | |i|pagename|runs| 13:57:53 INFO - PROCESS | 19233 | |0;ai-astar;101;109;109;111;110;110;110;110;109;110 13:57:53 INFO - PROCESS | 19233 | |1;audio-beat-detection;141;118;124;147;117;117;117;116;142;119 13:57:53 INFO - PROCESS | 19233 | |2;audio-dft;160;161;160;160;160;160;159;160;161;162 13:57:53 INFO - PROCESS | 19233 | |3;audio-fft;74;76;76;119;75;75;75;75;99;75 13:57:53 INFO - PROCESS | 19233 | |4;audio-oscillator;82;81;116;82;82;82;99;82;81;119 13:57:53 INFO - PROCESS | 19233 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;116 13:57:53 INFO - PROCESS | 19233 | |6;imaging-darkroom;146;146;146;146;145;146;145;145;145;145 13:57:53 INFO - PROCESS | 19233 | |7;imaging-desaturate;84;85;84;85;85;84;85;84;84;84 13:57:53 INFO - PROCESS | 19233 | |8;json-parse-financial;50;49;51;49;49;51;51;52;51;50 13:57:53 INFO - PROCESS | 19233 | |9;json-stringify-tinderbox;58;58;57;60;58;59;58;58;58;58 13:57:53 INFO - PROCESS | 19233 | |10;stanford-crypto-aes;81;74;84;75;78;82;75;74;74;74 13:57:53 INFO - PROCESS | 19233 | |11;stanford-crypto-ccm;126;124;124;140;122;126;118;121;176;120 13:57:53 INFO - PROCESS | 19233 | |12;stanford-crypto-pbkdf2;151;153;154;154;156;154;156;152;156;152 13:57:53 INFO - PROCESS | 19233 | |13;stanford-crypto-sha256-iterative;61;62;64;61;64;66;62;62;61;61 13:57:53 INFO - PROCESS | 19233 | __end_tp_report 13:57:53 INFO - PROCESS | 19233 | __start_cc_report 13:57:53 INFO - PROCESS | 19233 | _x_x_mozilla_cycle_collect,1581 13:57:53 INFO - PROCESS | 19233 | __end_cc_report 13:57:53 INFO - PROCESS | 19233 | __startTimestamp1485899873869__endTimestamp 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | ------- Summary: start ------- 13:57:53 INFO - PROCESS | 19233 | Number of tests: 14 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.85 (2.6%) stddev-sans-first:0.67 13:57:53 INFO - PROCESS | 19233 | Values: 101.0 109.0 109.0 111.0 110.0 110.0 110.0 110.0 109.0 110.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:121.50 stddev:12.39 (10.2%) stddev-sans-first:11.86 13:57:53 INFO - PROCESS | 19233 | Values: 141.0 118.0 124.0 147.0 117.0 117.0 117.0 116.0 142.0 119.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 13:57:53 INFO - PROCESS | 19233 | Values: 160.0 161.0 160.0 160.0 160.0 160.0 159.0 160.0 161.0 162.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:15.05 (20.1%) stddev-sans-first:15.69 13:57:53 INFO - PROCESS | 19233 | Values: 74.0 76.0 76.0 119.0 75.0 75.0 75.0 75.0 99.0 75.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:15.19 (18.5%) stddev-sans-first:15.79 13:57:53 INFO - PROCESS | 19233 | Values: 82.0 81.0 116.0 82.0 82.0 82.0 99.0 82.0 81.0 119.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:57:53 INFO - PROCESS | 19233 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:57:53 INFO - PROCESS | 19233 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 13:57:53 INFO - PROCESS | 19233 | Values: 84.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 84.0 84.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:51.00 stddev:1.06 (2.1%) stddev-sans-first:1.12 13:57:53 INFO - PROCESS | 19233 | Values: 50.0 49.0 51.0 49.0 49.0 51.0 51.0 52.0 51.0 50.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 13:57:53 INFO - PROCESS | 19233 | Values: 58.0 58.0 57.0 60.0 58.0 59.0 58.0 58.0 58.0 58.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.50 stddev:3.87 (5.1%) stddev-sans-first:3.84 13:57:53 INFO - PROCESS | 19233 | Values: 81.0 74.0 84.0 75.0 78.0 82.0 75.0 74.0 74.0 74.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:125.00 stddev:17.35 (13.9%) stddev-sans-first:18.35 13:57:53 INFO - PROCESS | 19233 | Values: 126.0 124.0 124.0 140.0 122.0 126.0 118.0 121.0 176.0 120.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:154.00 stddev:1.81 (1.2%) stddev-sans-first:1.62 13:57:53 INFO - PROCESS | 19233 | Values: 151.0 153.0 154.0 154.0 156.0 154.0 156.0 152.0 156.0 152.0 13:57:53 INFO - PROCESS | 19233 | 13:57:53 INFO - PROCESS | 19233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.71 (2.8%) stddev-sans-first:1.74 13:57:53 INFO - PROCESS | 19233 | Values: 61.0 62.0 64.0 61.0 64.0 66.0 62.0 62.0 61.0 61.0 13:57:53 INFO - PROCESS | 19233 | -------- Summary: end -------- 13:57:53 INFO - PROCESS | 19233 | 13:57:54 INFO - TEST-INFO | 19233: exit 0 13:57:54 INFO - TEST-OK | kraken | took 60026ms 13:57:54 INFO - SUITE-END | took 1174s 13:57:55 INFO - Completed test suite (00:19:34) 13:57:55 INFO - javascript benchmark 13:57:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3219.2756629758305, 3239.1740106272905, 3242.5622540956965, 3265.102096923346, 3282.524034015068, 5584.441555844419, 5683.573731970098, 5701.287339082614, 5713.285839270091, 5738.913916291253, 5607.831765047055, 5664.433556644333, 5667.716614169296, 5668.971655141719, 5706.99999999999, 5106.540411362977, 5126.92309615356, 5131.692098474104, 5171.405288391827, 5211.817586384477, 4987.0, 5022.799088036474, 5203.4796520348045, 5212.76542555584, 5240.135377662681, 5069.239614057884, 5091.567216786578, 5096.490350964892, 5105.361829771278, 5133.101707201244, 5137.922931156036, 5138.7173705446185, 5212.635115541913, 5219.112750832368, 5246.763895624668, 4888.633352498541, 5101.132807422747, 5108.2593024011685, 5163.3545806774155, 5181.5854731621375, 5471.316085489314, 5480.369757477902, 5494.395616482184, 5543.417941116165, 5547.195656629766, 5938.10928360745, 5946.197263369476, 5958.13607026983, 6019.518438524908, 6024.879502409927, 6056.576039677225, 6071.332153463116, 6073.4837538808815, 6081.239845019372, 6089.0866370044405, 5541.667499950016, 5576.888462230773, 5581.581381396411, 5621.15682647598, 5629.43705629442, 6148.262208535004, 6167.290761562478, 6173.41352571505, 6175.475084617858, 6187.504999600022, 5885.735141918538, 5887.1463637772285, 5895.823125306248, 5897.49871260939, 5912.526997840162, 5814.76740930358, 5867.882642347215, 5942.168096466498, 6020.0, 6028.095785632103, 6048.576599637983, 6053.939460605337, 6055.576109672369, 6058.1215723719815, 6068.059450785136, 6060.727267272983, 6062.030075187949, 6078.179445774852, 6079.331273559905, 6086.178365920544, 4532.478764942074, 4564.680472366969, 4591.79336929839, 4619.330197121399, 4669.906601868011, 4097.549269580344, 4127.938080928789, 4145.274576949022, 4148.668106551469, 4152.709310348247, 5698.088305871041, 5698.7435565399655, 5729.742161602738, 5750.6837123958585, 5767.250257466587, 5833.0, 5880.206172166702, 5973.163757074013, 6034.456898879122, 6055.152278680988, 5668.744906479218, 5755.625884317506, 5755.827325180251, 5773.884522309614, 5787.160861675034, 5001.549860512571, 5010.749462526859, 5012.448630650625, 5013.849584512471, 5049.469805670352, 6146.4468197861515, 6191.97832357674, 6281.466075383552, 6329.367063293634, 6348.428641422294, 5949.732262048132, 5981.431763982415, 6029.9698501508965, 6061.515078793774, 6106.786262480792, 6292.842678933063, 6325.367463253638, 6328.208973878265, 6332.11350410952, 6335.0, 5758.222639943721, 5969.432903874125, 5983.850403739767, 5988.431099045583, 6000.849978750566, 5825.097109947796, 6009.609375390585, 6066.878662426815, 6074.817755467343, 6131.988406491147, 5915.260592425947, 5967.731452084579, 5968.582199246011, 5977.551683623658, 5980.282366116094, 5956.255468066492, 5980.491658209101, 5981.162637230878, 5987.461128498282, 5988.431099045583, 5583.944160558342, 5776.451237132465, 5815.011448053926, 5856.150858125633, 5874.5887787854435, 5977.551683623833, 5979.0, 5981.611195272293, 5983.162357270073, 5993.280806303272, 5666.773329066791, 5684.886302273849, 5823.505002074871, 5825.126231065374, 5837.387074357302], "value": 5554.808147017168, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7236526467295, 612.8866159760444, 643.9098526206332, 648.5492582655054, 650.8340373204832, 35530.0, 38318.23363532731, 46519.30221046683, 47398.52601473993, 47539.76230118853, 48179.27731084036, 48577.75711121439, 48741.0, 48810.26784598234, 48811.75594122033, 8997.46015239086, 9089.863652045224, 9160.45037297761, 9171.403858749194, 9172.54137293136, 8471.32229421648, 8738.86891696625, 9055.95472022639, 10765.515551800188, 11040.392778397185, 11130.109591232722, 11166.385848778315, 11213.383263920481, 11213.887861121406, 11220.270682405659, 10784.245102842804, 10794.946025269903, 10819.404932728698, 10825.188110891715, 10837.945810270898, 8434.57827108642, 8708.564571771387, 10595.311304765242, 10947.781044379068, 10966.561337546489, 45246.0, 45662.086758264646, 45676.0, 45716.31425528586, 45745.77127114343, 3701.0747313171705, 3707.4253490708984, 3717.5910649828497, 3788.6796198416887, 4221.409002739619, 33212.346612040245, 33686.1578460538, 33921.0, 34765.13087172816, 35266.0, 4373.365861950031, 4453.821847126111, 4460.955390446086, 4491.955080449186, 4499.167653983991, 330477.0, 332427.0, 333449.0, 333486.0, 335759.0, 63583.68208158929, 63799.68100159562, 63806.36193638097, 63880.36119638744, 63930.36069639244, 68618.0, 68658.0, 68694.65652671705, 68735.31264687389, 68842.31157688459, 16171.110588917487, 16471.752923706154, 16474.341026359052, 16474.505764827074, 16475.0, 11383.203175777617, 13323.733525329439, 13341.399637016164, 13363.532276370475, 13434.126781759154, 17220.569485762957, 19321.51696207606, 19455.09065273945, 20259.493512662302, 20441.182352706022, 6490.0, 6552.6068435894, 6581.638009909501, 6669.899951500732, 6687.264400915896, 978.0512902484578, 1047.7642530430592, 1050.9632162874263, 1085.685151306128, 1121.556984990924, 33640.327193455996, 33685.83157084199, 33900.66099338975, 33939.66060339414, 34349.0, 1181.1377694283221, 1194.062660811259, 1224.8162775583735, 1226.5645695778048, 1237.3442075699893, 17761.644767104586, 17940.730889036677, 18038.90980545089, 18048.187831547613, 18158.0, 499004.0, 501738.0, 503720.0, 504196.0, 505038.0, 63258.36741632617, 63337.68331158407, 63475.682621586595, 63512.36487635157, 63536.68231658812, 1275.515304184404, 1335.2922950835878, 1355.966100847467, 1369.575431616222, 1434.8278206615273, 29956.101316959655, 35000.29999400049, 35071.29857402787, 35220.0, 35399.64600353964, 52241.47758522366, 52832.20751688651, 52941.0, 52945.7352713234, 52954.2056869155, 376333.0, 380904.0, 380931.0, 381754.0, 382920.0, 36683.81658091799, 37051.8147409272, 38122.237555249296, 41243.587564123976, 46588.53411465842, 48050.0, 49200.50799491959, 49379.25931110964, 49508.50491495039, 49782.0, 41541.79229103835, 41702.582974171084, 42267.57732422637, 43147.0, 43907.560924390345, 41107.383389248585, 41278.0, 41844.79077604593, 43058.78470607627, 43086.0, 42111.7894410526, 42794.14411711811, 43677.12645747004, 43851.342229867216, 43869.561304386545, 35788.28423431569, 37360.81319593385, 38012.80993595014, 38149.23701526009, 38335.0, 28312.85843570769, 28624.71002319851, 28719.569206461503, 29025.564616531192, 29049.7095029047], "value": 21194.606325738554, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.264680192658, 417.83286685325845, 428.5478819845063, 430.7458599426339, 445.3853681918951, 18741.62516749664, 18832.52918677032, 20594.38216853497, 20611.484712882168, 20741.170353185855, 19684.409467715956, 19954.501137471536, 20144.194232230693, 20672.586548269024, 20764.27325043624, 5859.238299021121, 6114.785982490614, 6131.202943617323, 6133.355997620252, 6140.969295153518, 5880.088586269114, 5986.8503287417725, 6012.789552365668, 6022.096685497188, 6126.417990290915, 5924.0521516557355, 5942.5840191186635, 5949.762009519614, 5951.137085122655, 5982.910256346158, 5758.827235182951, 5937.406259374071, 5960.612560183596, 5989.341172471025, 5999.430054144849, 5440.183972404131, 5440.863978400532, 5446.2375267462585, 5451.155070964007, 5451.3458384993655, 23750.881245593835, 23832.76167238323, 24075.0, 24077.157299494607, 24500.877495612407, 2462.5444292805887, 2581.3675649465813, 2663.6537250157357, 2687.6640419947507, 2762.8342299462097, 10841.295315804447, 15331.846681533265, 15423.383064677511, 15426.614334641723, 15459.227038648023, 2005.037581960667, 2070.3892351756117, 2086.1029757204396, 2112.155137944819, 2114.0, 86102.13897861003, 90848.0, 90900.54549727275, 92641.0, 93358.0, 11927.403629818475, 12008.339541325311, 12095.21381110225, 12156.270623762603, 12352.691182720504, 17130.828691713174, 17136.0, 17147.57131071708, 17152.399666011628, 17171.227294771765, 8279.213474719892, 8412.915870841212, 8624.611892464854, 8632.309415246766, 8800.955995219983, 7758.728444504415, 7901.881471777928, 8261.297789687824, 8494.660213591511, 8495.405321627426, 5133.486651334837, 5178.990096931062, 5186.844394668166, 5224.085784987688, 5315.867103322448, 2101.947451313699, 2160.1143531152466, 2174.1629472652826, 2174.510735084625, 2185.726784151981, 915.3592485260211, 965.9471176417738, 974.5663179885025, 1015.2284263959444, 1053.7365658585354, 20260.594788104154, 20350.694739578918, 20422.08100635475, 20461.693074603892, 20802.895985519976, 966.5215718219386, 997.3915911294105, 1009.1069403577886, 1038.1746511523356, 1049.8162821506205, 10652.254342196127, 11365.261258018203, 11424.975527898203, 11741.4716337765, 11823.408829558659, 476672.0, 479511.0, 480259.0, 500113.0, 502598.0, 92770.53614731884, 93209.0, 93721.0, 95353.52323238339, 95931.52034239784, 962.8651988721584, 977.5503268496429, 990.3562684255292, 994.7165057958447, 995.5072239241622, 17729.0, 17765.733513997042, 18489.0, 18502.907485462485, 18518.0, 43138.13723725571, 43429.78285108554, 43460.348094779234, 43626.56373436225, 44340.11319773651, 53937.460625394815, 57147.714261428424, 57875.0, 58568.414315858, 58732.41267587269, 8208.876866846882, 8403.285720713564, 8961.551922403984, 9000.144986226298, 9424.764380890532, 9765.804683906425, 13705.314734263446, 13894.166350019032, 14336.354864030935, 14457.421703131757, 11730.237534560227, 11987.64037078889, 12074.879251207376, 12702.491900323883, 12836.101472896808, 12206.694832629255, 12214.08394370408, 12222.266664000188, 12235.32705701195, 12711.55509557161, 12638.873611264138, 12650.683732906751, 12672.556460523838, 12862.421191046613, 12982.35088245565, 8524.403291769517, 8644.005939316807, 8796.340274479311, 8799.47203167812, 8810.383273170817, 11315.660530184108, 12193.69515762113, 12257.632271031884, 12475.500979961063, 12699.809502857279], "value": 9742.455123332673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.7579435701582, 1494.5217530390273, 1533.5935976966102, 1662.5843539115222, 1789.1839782620643, 8062.435629505937, 8798.0, 9088.136627020422, 9096.0449152839, 9306.0, 9121.863172052408, 9183.632654693803, 9185.724428267162, 9201.079892010795, 9216.447013179213, 2510.548101341758, 2532.5441420544294, 2540.415704387992, 2540.8602526861014, 2552.0429838810446, 2492.3519884829893, 2597.2727636261784, 2613.1376645706964, 2613.255222261656, 2617.8952841886303, 2517.25740906433, 2532.278300684305, 2581.1095172165574, 2588.9902937854254, 2593.610958356243, 2493.9750602494014, 2512.472380800034, 2532.962005569918, 2549.4518678484214, 2550.4134049168797, 2482.962755558668, 2491.813114016456, 2514.9311542594323, 2517.9118730844516, 2533.936651583707, 8993.460392376479, 9078.818423631556, 9096.63613455461, 9164.6792362267, 9176.81646367069, 5609.551235901118, 5821.155932389822, 5856.267966504187, 5857.238558987305, 5858.677772722499, 3483.198864261234, 3606.296772129436, 3622.3841946869097, 3687.2441149564274, 3689.9889560189763, 1216.1669256559285, 1226.693326668333, 1236.969075773104, 1282.1089342906685, 1315.83552055993, 12804.551840685532, 12860.0, 12927.418266178045, 12934.48262069516, 12934.805977910339, 4728.290756386501, 4929.654924155347, 4958.082754690394, 4981.526754958273, 5041.294218809369, 10234.846477302846, 10241.692749217535, 10248.538815753309, 10251.179905607534, 10253.794924101476, 5719.542436605062, 5720.0, 5728.1407788831175, 5734.741936612862, 5737.569682273846, 4440.4227450431235, 4674.929876051862, 4728.290756386501, 5180.81867134656, 5286.656367336111, 4138.1585194588115, 4182.456280683492, 4224.155168966219, 4252.468441444819, 4283.807228674717, 1300.0639539531521, 1323.3184909771476, 1324.6754545136503, 1336.3719052045524, 1338.3642769684323, 881.6341218394423, 1032.6643840751785, 1037.419045334615, 1045.639254457211, 1048.4286064095086, 5962.850928726816, 5982.192404025401, 6071.574989750675, 6174.166487524217, 6244.687765611792, 486.7809485731364, 505.507130547713, 507.959363250939, 513.7842106315281, 1023.1967905194387, 4128.0, 4249.6387807036745, 4272.914541709149, 4346.935000924794, 4374.12517496502, 11259.831102533468, 11498.02266807314, 11583.189176757714, 11610.535578576932, 11631.418429078512, 11545.36500492481, 11549.595764148215, 11549.826752598718, 11561.653150405502, 11571.30572165656, 8585.828283434297, 8631.6978905738, 8711.825763484821, 8810.163034511712, 8810.911890881138, 6065.848353791191, 6102.511799056154, 6122.357152498924, 6184.412480814315, 6193.907091393723, 10251.794964100825, 10467.267291289536, 10478.947605261925, 10565.418901960466, 10581.4709264538, 9450.43297402158, 9755.609775608897, 10217.233707472118, 10639.255252132276, 10640.308379955279, 7448.5158464699625, 7745.845083098419, 7769.689212431439, 7823.374130069467, 7831.707768218408, 8717.346199034972, 8784.78038049054, 8788.824223515621, 8794.384393092421, 8797.428167169113, 7668.463207575416, 7788.104367997526, 7899.763007109796, 7984.24149705777, 8041.356691464785, 7687.692492300245, 7715.961420193088, 7762.805929851799, 7772.45592808498, 7781.105172905189, 7121.181064177686, 7139.785806425815, 7191.820204494929, 7312.670929808278, 7391.7434036215045, 5161.948380516297, 5336.012837625051, 5340.706261155674, 5345.1714984177515, 5388.38033626138, 5281.471852814688, 5461.590380721383, 5508.394076651645, 5528.143137813645, 5690.146478028329], "value": 4805.063949300195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.6941079501461, 332.02384988134884, 335.34272825262485, 348.90405138586885, 350.508931046774, 5356.330458692663, 5518.1998610201545, 5519.889602207953, 5531.3915469298445, 5618.4662457066515, 5446.373667028293, 5463.48096930791, 5477.3427188737305, 5485.780568777244, 5503.394626591072, 4313.396124542566, 4322.351647252914, 4332.696711230215, 4341.50072741634, 4373.343998400233, 3807.3527500325013, 4109.486314210723, 4197.454330936974, 4305.763183024932, 4327.0913108247305, 4259.2546304396765, 4262.211490874182, 4267.359896015607, 4275.7434553926705, 4281.614654681078, 4281.978590107061, 4290.4851417829905, 4293.914121717564, 4303.160883627694, 4303.526612072669, 3651.8721844735574, 3779.4897688811934, 3824.7896365699876, 3825.3496905526126, 3836.5396152461603, 5265.97313523863, 5274.393444753864, 5284.603654725911, 5295.735213239323, 5303.337082864642, 4899.853004409873, 4905.509449055102, 4908.870959679258, 4921.458639549683, 4924.556789888891, 5597.272354593917, 5633.070543360341, 5664.461876121762, 5715.885682286331, 5731.426857314277, 4151.8546850860375, 4154.003039270584, 4155.148194620096, 4157.750534967911, 4177.832886684529, 5574.163875418679, 5753.971230143822, 5881.6471011739, 5911.674857882815, 5920.822375328747, 4121.928298642375, 4200.91598168041, 4206.978965105155, 4218.873433796991, 4223.640990515779, 4270.807813648394, 4273.658107351404, 4278.058827058042, 4297.548757380492, 4323.891902702458, 4756.405449318835, 4818.855434336975, 4887.437944636341, 4917.139500587383, 4932.753362331869, 5650.898074875442, 5668.404817494186, 5695.430456954355, 5695.45893140151, 5724.16999535065, 1411.2167746900363, 1418.5673369622364, 1423.3879431844407, 1426.9500567480088, 1432.6633241188313, 957.5923392612987, 997.3666721631816, 1005.0351662404174, 1009.7728011197422, 1011.3123076308034, 5262.894742105136, 5288.68267903927, 5294.205869119663, 5318.414974352818, 5319.787208511616, 5542.473465020817, 5553.444655534414, 5558.499735023867, 5579.860503487445, 5594.664320140804, 5082.313887625197, 5250.947490525123, 5282.418933917266, 5301.602379821529, 5314.92027619586, 2943.45546073977, 2951.099914526047, 2955.2907302247304, 2980.5231163013814, 2987.6116104906223, 5763.2507773989955, 5790.826275211751, 5829.5044921181325, 5835.328937172195, 5864.413558644102, 5686.4646545433325, 6003.669798161056, 6006.2191915051635, 6018.909716354258, 6020.608660437058, 6125.816225513242, 6130.63216207029, 6131.172291740558, 6135.5398345124295, 6187.133801267826, 5566.888662226814, 5755.769769209185, 5775.364709881826, 5847.473727364558, 5892.705364731661, 5780.2485676863425, 5782.212650713789, 5793.884122317614, 5833.883322333614, 5849.824505264849, 5874.089516125007, 5901.940980590311, 5944.8811023780145, 6054.455099041107, 6101.908471372844, 4237.470316210473, 4247.87256382309, 4257.403963445058, 4275.273203555341, 4278.117628243563, 5699.803041361361, 5904.586678932434, 5928.170056192051, 5932.080527518242, 5933.139694744152, 5662.773489060556, 5666.688332141772, 5687.203791469115, 5691.203231547669, 5714.857128571819, 5692.975264452439, 5701.173329867063, 5707.914381284367, 5737.225474560881, 5746.770129194785, 5508.338999320107, 5668.712146954674, 5701.828945131652, 5703.714814259353, 5730.71346432685, 5717.656940583578, 5717.685527296038, 5728.169415434655, 5730.398308177581, 5734.111212762028, 5575.498205161555, 5596.216529685928, 5607.158926161109, 5620.4660557247, 5632.295963004624], "value": 4344.799928968079, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.8891355210271, 798.7084714079363, 819.4468733604815, 834.4867906237664, 915.1534830281987, 14738.410463581456, 15783.210839458025, 16064.27710753016, 16236.107014114219, 16340.509784706448, 13842.0, 13843.030987830856, 13967.720645587082, 14102.36539355729, 14215.360308786103, 729.8613263479948, 836.8200836820098, 850.2347886901807, 850.5279569838737, 851.1913682002091, 731.144560863788, 858.9785255368603, 871.485823364215, 876.119499902597, 876.5135349880813, 891.8394688955985, 898.5597057441872, 903.1555495611591, 903.7695387676133, 904.0326850270213, 900.2572877376191, 900.5632268349846, 900.779309069279, 901.4230892228978, 902.5442151713409, 661.3849120318102, 661.7915356662684, 661.9768308109193, 662.4766434516725, 662.8342914271432, 14501.27493625325, 14808.851911480855, 14818.0, 14861.777073343908, 15048.097114173075, 14894.329755161043, 15343.0, 15617.687646247125, 15676.921615391964, 15745.527634170992, 11740.236884602473, 11909.642710718692, 11968.640940771791, 12048.397580121047, 12141.392930353448, 4493.146302202571, 4495.033567782943, 4529.388532548097, 4553.658475614309, 4743.573078422958, 63011.05483417798, 63022.0, 63210.36789632137, 64575.0, 64936.3506364935, 11549.249298795552, 11599.188056836108, 11621.593244236412, 11637.359945202927, 11750.647480575426, 20154.899225503777, 20161.092750826247, 20220.39338819838, 20249.08879100444, 20311.59376812485, 8159.0, 8167.509949403055, 8426.915730842737, 8432.789180270542, 8540.786480338042, 4566.383538222298, 4607.170709272363, 4750.596199323028, 4807.423109226916, 4834.758262086882, 3592.497050412944, 3755.849766009329, 3762.0406796266775, 3765.171662234304, 3765.981170094132, 624.356912380249, 634.4004915354946, 648.8377905523619, 652.0935899100255, 657.8782925158861, 576.5992635118553, 649.2176926803285, 695.7912626212116, 707.4189187166678, 715.9319864612853, 8970.641174352953, 9232.122948319899, 9249.0, 9331.393459425115, 9433.575489103006, 672.6838385958591, 672.862063277027, 675.0481820632884, 676.1210426445699, 685.4550632247375, 4232.703710740218, 4363.432753741993, 4390.1878152541885, 4392.253316936129, 4448.55514448559, 91873.0812691878, 91879.0, 92189.53905230566, 93066.0, 95717.5214123925, 49140.0, 64129.35870641234, 73492.0, 79855.60072199602, 83117.16882831094, 65359.67320163369, 66690.0, 67482.3251767476, 67783.98324025143, 68582.97125543121, 9912.903564308042, 9935.900640993497, 10052.132466114013, 10349.63776267827, 10375.792484150426, 39053.80473097616, 39127.60872391354, 41352.79323603363, 41714.37428438515, 43673.78163109164, 39941.40087898626, 41996.95007624834, 42346.0, 56506.71746641405, 62923.6853815728, 12479.438425271066, 12613.432395542406, 12883.48466061347, 12975.935120324339, 13053.738925221252, 14279.429262781294, 14463.49377771773, 14495.275236237934, 14775.92612036933, 14932.701345973237, 13777.586672399844, 13880.375383107987, 14194.0, 14398.42406303778, 15189.6202594936, 12503.56237531682, 12734.68163295925, 13297.933510332387, 13361.866381336062, 13688.52090176839, 13005.804912926125, 13245.602631921058, 13283.734325313633, 13547.59357219285, 14216.289185540889, 11441.48513316886, 11579.42102894835, 11674.649760507198, 11975.401229938643, 12231.69420764488, 11493.48279327449, 11787.587434440096, 11847.822282665938, 11900.702482438008, 12098.818517722066], "value": 7315.777935065922, "unit": "score"}], "name": "dromaeo_css", "value": 7480.3654614226325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 124.0, 147.0, 117.0, 117.0, 117.0, 116.0, 142.0, 119.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 119.0, 75.0, 75.0, 75.0, 75.0, 99.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 116.0, 82.0, 82.0, 82.0, 99.0, 82.0, 81.0, 119.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 51.0, 49.0, 49.0, 51.0, 51.0, 52.0, 51.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 60.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 84.0, 75.0, 78.0, 82.0, 75.0, 74.0, 74.0, 74.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 124.0, 140.0, 122.0, 126.0, 118.0, 121.0, 176.0, 120.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 154.0, 154.0, 156.0, 154.0, 156.0, 152.0, 156.0, 152.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 61.0, 64.0, 66.0, 62.0, 62.0, 61.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1445.7, "alertThreshold": 2.0}]} 13:57:55 INFO - Return code: 0 13:57:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:57:55 INFO - # TBPL SUCCESS # 13:57:55 INFO - Running post-action listener: _resource_record_post_action 13:57:55 INFO - [mozharness: 2017-01-31 21:57:55.186150Z] Finished run-tests step (success) 13:57:55 INFO - Running post-run listener: _resource_record_post_run 13:57:55 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324493312; Read time: 16; Write time: 280724 13:57:55 INFO - TinderboxPrint: CPU usage
12.9% 13:57:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:57:55 INFO - TinderboxPrint: I/O write bytes / time
324,493,312 / 280,724 13:57:55 INFO - TinderboxPrint: CPU idle
8,264.0 (87.1%) 13:57:55 INFO - TinderboxPrint: CPU user
1,182.3 (12.5%) 13:57:55 INFO - TinderboxPrint: Swap in / out
0 / 0 13:57:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 106147840; Read time: 0; Write time: 136768 13:57:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218345472; Read time: 16; Write time: 143956 13:57:55 INFO - Running post-run listener: _upload_blobber_files 13:57:55 INFO - Blob upload gear active. 13:57:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:57:55 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 13:57:55 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:57:55 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:57:56 INFO - (blobuploader) - INFO - Open directory for files ... 13:57:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:57:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:59 INFO - (blobuploader) - INFO - Done attempting. 13:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:00 INFO - (blobuploader) - INFO - Done attempting. 13:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:01 INFO - (blobuploader) - INFO - Done attempting. 13:58:01 INFO - (blobuploader) - INFO - Iteration through files over. 13:58:01 INFO - Return code: 0 13:58:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:58:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:58:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae6583b58b58611aa2e56cbb6ac92ebe9027535aece726ce5af69cffc6c493e4a6842507785fa2a793fab417bd4e60c5507624ec4ef85319a9491b57f3af24a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10bebf6ed8e6030c2b378ee43a677ed2cd966778bc6e276cd764d61a19b2cf445029008c9a713d4f1105d2579b60041ed0c45faf6c0253d322c4aeb56afec112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4571b9fa96876b46bc8edc5cfe7d5439a5bece8120b0409d961f3990c194815f34e7489ac8e3e2a07083d3203ac91edec4d8461aaffee7e6f6c890f9b45d4cb1"} 13:58:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:58:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:58:01 INFO - Contents: 13:58:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae6583b58b58611aa2e56cbb6ac92ebe9027535aece726ce5af69cffc6c493e4a6842507785fa2a793fab417bd4e60c5507624ec4ef85319a9491b57f3af24a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10bebf6ed8e6030c2b378ee43a677ed2cd966778bc6e276cd764d61a19b2cf445029008c9a713d4f1105d2579b60041ed0c45faf6c0253d322c4aeb56afec112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4571b9fa96876b46bc8edc5cfe7d5439a5bece8120b0409d961f3990c194815f34e7489ac8e3e2a07083d3203ac91edec4d8461aaffee7e6f6c890f9b45d4cb1"} 13:58:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:58:01 INFO - Copying logs to upload dir... 13:58:01 INFO - mkdir: /builds/slave/test/build/upload/logs 13:58:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.383559 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-31 13:58:00.945754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 13:58:00.950017) ========= 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=d2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae6583b58b58611aa2e56cbb6ac92ebe9027535aece726ce5af69cffc6c493e4a6842507785fa2a793fab417bd4e60c5507624ec4ef85319a9491b57f3af24a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10bebf6ed8e6030c2b378ee43a677ed2cd966778bc6e276cd764d61a19b2cf445029008c9a713d4f1105d2579b60041ed0c45faf6c0253d322c4aeb56afec112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4571b9fa96876b46bc8edc5cfe7d5439a5bece8120b0409d961f3990c194815f34e7489ac8e3e2a07083d3203ac91edec4d8461aaffee7e6f6c890f9b45d4cb1"} build_url:https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/ceK7iN7uQcWkxgJjmN9LvQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae6583b58b58611aa2e56cbb6ac92ebe9027535aece726ce5af69cffc6c493e4a6842507785fa2a793fab417bd4e60c5507624ec4ef85319a9491b57f3af24a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10bebf6ed8e6030c2b378ee43a677ed2cd966778bc6e276cd764d61a19b2cf445029008c9a713d4f1105d2579b60041ed0c45faf6c0253d322c4aeb56afec112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4571b9fa96876b46bc8edc5cfe7d5439a5bece8120b0409d961f3990c194815f34e7489ac8e3e2a07083d3203ac91edec4d8461aaffee7e6f6c890f9b45d4cb1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 13:58:00.977976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:58:00.978387) ========= 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=d2a8c569965ab8367867b893000001a1-1485898645.632573-2070908674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:58:01.059699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 13:58:01.060254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 13:58:01.060779) ========= ========= Total master_lag: 0.51 =========