builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1491832412.3 results: success (0) revision: e428ad55a70464accb5439b1a1285c6f565c17aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.302928) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.303342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.303664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.318116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.318447) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-10 06:53:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-04-10 06:53:32 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112344 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.444569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.444919) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015649 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:32.495347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 06:53:32.498826) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e428ad55a70464accb5439b1a1285c6f565c17aa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e428ad55a70464accb5439b1a1285c6f565c17aa --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=88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-10 06:53:32,829 truncating revision to first 12 chars 2017-04-10 06:53:32,829 Setting DEBUG logging. 2017-04-10 06:53:32,829 attempt 1/10 2017-04-10 06:53:32,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e428ad55a704?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 06:53:33,532 unpacking tar archive at: mozilla-aurora-e428ad55a704/testing/mozharness/ program finished with exit code 0 elapsedTime=0.991089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 06:53:33.502904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:33.503218) ========= script_repo_revision: e428ad55a70464accb5439b1a1285c6f565c17aa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:33.506599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:33.506874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 06:53:33.516564) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-10 06:53:33.516866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:53:33 INFO - MultiFileLogger online at 20170410 06:53:33 in /builds/slave/test 06:53:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 06:53:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:53:33 INFO - {'append_to_log': False, 06:53:33 INFO - 'base_work_dir': '/builds/slave/test', 06:53:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 06:53:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:53:33 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 06:53:33 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:33 INFO - 'config_files': ('talos/linux_config.py',), 06:53:33 INFO - 'default_actions': ('clobber', 06:53:33 INFO - 'read-buildbot-config', 06:53:33 INFO - 'download-and-extract', 06:53:33 INFO - 'populate-webroot', 06:53:33 INFO - 'create-virtualenv', 06:53:33 INFO - 'install', 06:53:33 INFO - 'run-tests'), 06:53:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:33 INFO - 'download_minidump_stackwalk': True, 06:53:33 INFO - 'download_symbols': 'ondemand', 06:53:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:33 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:33 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:33 INFO - 'gecko_profile': False, 06:53:33 INFO - 'gecko_profile_interval': 0, 06:53:33 INFO - 'installer_path': 'installer.exe', 06:53:33 INFO - 'log_level': 'info', 06:53:33 INFO - 'log_name': 'talos', 06:53:33 INFO - 'log_to_console': True, 06:53:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:53:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:53:33 INFO - 'opt_config_files': (), 06:53:33 INFO - 'pip_index': False, 06:53:33 INFO - 'suite': 'dromaeojs', 06:53:33 INFO - 'system_bits': '32', 06:53:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:33 INFO - 'title': 'talos-linux64-ix-044', 06:53:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:33 INFO - 'use_talos_json': True, 06:53:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:53:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:33 INFO - 'work_dir': 'build'} 06:53:33 INFO - [mozharness: 2017-04-10 13:53:33.949016Z] Running clobber step. 06:53:33 INFO - Running pre-action listener: _resource_record_pre_action 06:53:33 INFO - Running main action method: clobber 06:53:33 INFO - rmtree: /builds/slave/test/build 06:53:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:53:34 INFO - Running post-action listener: _resource_record_post_action 06:53:34 INFO - [mozharness: 2017-04-10 13:53:34.976535Z] Finished clobber step (success) 06:53:34 INFO - [mozharness: 2017-04-10 13:53:34.976634Z] Running read-buildbot-config step. 06:53:34 INFO - Running pre-action listener: _resource_record_pre_action 06:53:34 INFO - Running main action method: read_buildbot_config 06:53:34 INFO - Using buildbot properties: 06:53:34 INFO - { 06:53:34 INFO - "project": "", 06:53:34 INFO - "product": "firefox", 06:53:34 INFO - "who": "cbook@mozilla.com", 06:53:34 INFO - "installer_path": "public/build/target.tar.bz2", 06:53:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:53:34 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 06:53:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 06:53:34 INFO - "stage_platform": "linux64", 06:53:34 INFO - "basedir": "/builds/slave/test", 06:53:34 INFO - "buildnumber": 123, 06:53:34 INFO - "platform": "ubuntu64_hw", 06:53:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:53:34 INFO - "slavebuilddir": "test", 06:53:34 INFO - "taskId": "OcajSDiXSpGLtv5ks8KSMA", 06:53:34 INFO - "branch": "mozilla-aurora", 06:53:34 INFO - "script_repo_revision": "production", 06:53:34 INFO - "revision": "e428ad55a70464accb5439b1a1285c6f565c17aa", 06:53:34 INFO - "slavename": "talos-linux64-ix-044", 06:53:34 INFO - "repo_path": "releases/mozilla-aurora" 06:53:34 INFO - } 06:53:34 INFO - Finding installer, test and symbols from parent task. 06:53:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OcajSDiXSpGLtv5ks8KSMA'}, attempt #1 06:53:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OcajSDiXSpGLtv5ks8KSMA'}, attempt #1 06:53:35 INFO - Task dependencies: UvA_yJL2SZOnrEo4tVr9IA 06:53:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA'}, attempt #1 06:53:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2 06:53:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/test_packages.json 06:53:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.crashreporter-symbols.zip 06:53:36 INFO - Running post-action listener: _resource_record_post_action 06:53:36 INFO - [mozharness: 2017-04-10 13:53:36.357964Z] Finished read-buildbot-config step (success) 06:53:36 INFO - [mozharness: 2017-04-10 13:53:36.358219Z] Running download-and-extract step. 06:53:36 INFO - Running pre-action listener: _resource_record_pre_action 06:53:36 INFO - Running main action method: download_and_extract 06:53:36 INFO - mkdir: /builds/slave/test/build/tests 06:53:36 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')]} 06:53:36 INFO - trying https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.test_packages.json 06:53:36 INFO - Downloading https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:53:36 INFO - Downloaded 896 bytes. 06:53:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:53:36 INFO - Using the following test package requirements: 06:53:36 INFO - {u'common': [u'target.common.tests.zip'], 06:53:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:53:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:53:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:53:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:53:36 INFO - u'mozbase': [u'target.common.tests.zip'], 06:53:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:53:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:53:36 INFO - u'web-platform': [u'target.common.tests.zip', 06:53:36 INFO - u'target.web-platform.tests.zip'], 06:53:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:53:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:53:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.common.tests.zip 06:53:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:53:36 INFO - Fetch https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.common.tests.zip into memory 06:53:38 INFO - Expected file size: 59549967 06:53:38 INFO - Obtained file size: 59549967 06:53:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:53:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.common.tests.zip 06:53:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:53:47 INFO - Fetch https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.common.tests.zip into memory 06:53:48 INFO - Expected file size: 59549967 06:53:48 INFO - Obtained file size: 59549967 06:53:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.talos.tests.zip 06:53:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:53:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.talos.tests.zip into memory 06:53:59 INFO - Expected file size: 14404424 06:53:59 INFO - Obtained file size: 14404424 06:54: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')]} 06:54:00 INFO - trying https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2 06:54:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:54:01 INFO - Downloaded 66700566 bytes. 06:54:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2 06:54:01 INFO - mkdir: /builds/slave/test/properties 06:54:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:01 INFO - Contents: 06:54:01 INFO - build_url:https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2 06:54:01 INFO - Running post-action listener: _resource_record_post_action 06:54:01 INFO - Running post-action listener: set_extra_try_arguments 06:54:01 INFO - [mozharness: 2017-04-10 13:54:01.181668Z] Finished download-and-extract step (success) 06:54:01 INFO - [mozharness: 2017-04-10 13:54:01.181764Z] Running populate-webroot step. 06:54:01 INFO - Running pre-action listener: _resource_record_pre_action 06:54:01 INFO - Running main action method: populate_webroot 06:54:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:01 INFO - '--tppagecycles', 06:54:01 INFO - '7'], 06:54:01 INFO - 'tests': ['tsvgm']}}, 06:54:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:54:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:54:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:54:01 INFO - 'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:54:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:54:01 INFO - 'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['damp', 'tps']}, 06:54:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:54:01 INFO - 'tests': ['damp', 'tps']}, 06:54:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['dromaeo_dom']}, 06:54:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['basic_compositor_video']}, 06:54:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:54:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['a11yr', 06:54:01 INFO - 'ts_paint', 06:54:01 INFO - 'tpaint', 06:54:01 INFO - 'sessionrestore', 06:54:01 INFO - 'sessionrestore_no_auto_restore', 06:54:01 INFO - 'tabpaint']}, 06:54:01 INFO - 'other-e10s': {'tests': ['a11yr', 06:54:01 INFO - 'ts_paint', 06:54:01 INFO - 'tpaint', 06:54:01 INFO - 'sessionrestore', 06:54:01 INFO - 'sessionrestore_no_auto_restore', 06:54:01 INFO - 'tabpaint']}, 06:54:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:54:01 INFO - 'ts_paint', 06:54:01 INFO - 'tpaint', 06:54:01 INFO - 'sessionrestore', 06:54:01 INFO - 'sessionrestore_no_auto_restore', 06:54:01 INFO - 'tabpaint']}, 06:54:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:54:01 INFO - 'ts_paint', 06:54:01 INFO - 'tpaint', 06:54:01 INFO - 'sessionrestore', 06:54:01 INFO - 'sessionrestore_no_auto_restore', 06:54:01 INFO - 'tabpaint']}, 06:54:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['a11yr', 06:54:01 INFO - 'ts_paint', 06:54:01 INFO - 'tpaint', 06:54:01 INFO - 'sessionrestore', 06:54:01 INFO - 'sessionrestore_no_auto_restore', 06:54:01 INFO - 'tabpaint']}, 06:54:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['a11yr', 06:54:01 INFO - 'ts_paint', 06:54:01 INFO - 'tpaint', 06:54:01 INFO - 'sessionrestore', 06:54:01 INFO - 'sessionrestore_no_auto_restore', 06:54:01 INFO - 'tabpaint']}, 06:54:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['tsvgx', 06:54:01 INFO - 'tsvgr_opacity', 06:54:01 INFO - 'tart', 06:54:01 INFO - 'tscrollx', 06:54:01 INFO - 'cart', 06:54:01 INFO - 'tsvg_static']}, 06:54:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:54:01 INFO - 'tsvgr_opacity', 06:54:01 INFO - 'tart', 06:54:01 INFO - 'tscrollx', 06:54:01 INFO - 'cart', 06:54:01 INFO - 'tsvg_static']}, 06:54:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:54:01 INFO - 'talos_options': ['--disable-e10s'], 06:54:01 INFO - 'tests': ['tp5o']}, 06:54:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:54:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:54:01 INFO - 'talos_options': ['--disable-e10s', 06:54:01 INFO - '--xperf_path', 06:54:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:01 INFO - 'tests': ['tp5n']}, 06:54:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:54:01 INFO - 'talos_options': ['--xperf_path', 06:54:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:01 INFO - 'tests': ['tp5n']}}, 06:54:01 INFO - 'talos.zip': {'path': '', 06:54:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:01 INFO - Running post-action listener: _resource_record_post_action 06:54:01 INFO - [mozharness: 2017-04-10 13:54:01.194953Z] Finished populate-webroot step (success) 06:54:01 INFO - [mozharness: 2017-04-10 13:54:01.195043Z] Running create-virtualenv step. 06:54:01 INFO - Running pre-action listener: _resource_record_pre_action 06:54:01 INFO - Running main action method: create_virtualenv 06:54:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:01 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 06:54:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:01 INFO - Using real prefix '/usr' 06:54:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:03 INFO - Installing pip.................done. 06:54:03 INFO - Return code: 0 06:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:54:03 INFO - Reading from file tmpfile_stdout 06:54:03 INFO - Output received: 06:54:03 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) 06:54:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54:03 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')]} 06:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:03 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')]} 06:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:04 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:04 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 06:54:04 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 06:54:04 INFO - Using env: {'DISPLAY': ':0', 06:54:04 INFO - 'HOME': '/home/cltbld', 06:54:04 INFO - 'LANG': 'en_US.UTF-8', 06:54:04 INFO - 'LANGUAGE': 'en_US:en', 06:54:04 INFO - 'LOGNAME': 'cltbld', 06:54:04 INFO - 'MAIL': '/var/mail/cltbld', 06:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:04 INFO - 'MOZ_NO_REMOTE': '1', 06:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:04 INFO - 'NO_EM_RESTART': '1', 06:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:04 INFO - 'PWD': '/builds/slave/test', 06:54:04 INFO - 'SHELL': '/bin/bash', 06:54:04 INFO - 'SHLVL': '1', 06:54:04 INFO - 'TERM': 'linux', 06:54:04 INFO - 'TMOUT': '86400', 06:54:04 INFO - 'USER': 'cltbld', 06:54:04 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:04 INFO - '_': '/tools/buildbot/bin/python'} 06:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:04 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 06:54:04 INFO - Cleaning up... 06:54:04 INFO - Return code: 0 06:54:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:04 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:04 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 06:54:04 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 06:54:04 INFO - Using env: {'DISPLAY': ':0', 06:54:04 INFO - 'HOME': '/home/cltbld', 06:54:04 INFO - 'LANG': 'en_US.UTF-8', 06:54:04 INFO - 'LANGUAGE': 'en_US:en', 06:54:04 INFO - 'LOGNAME': 'cltbld', 06:54:04 INFO - 'MAIL': '/var/mail/cltbld', 06:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:04 INFO - 'MOZ_NO_REMOTE': '1', 06:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:04 INFO - 'NO_EM_RESTART': '1', 06:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:04 INFO - 'PWD': '/builds/slave/test', 06:54:04 INFO - 'SHELL': '/bin/bash', 06:54:04 INFO - 'SHLVL': '1', 06:54:04 INFO - 'TERM': 'linux', 06:54:04 INFO - 'TMOUT': '86400', 06:54:04 INFO - 'USER': 'cltbld', 06:54:04 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:04 INFO - '_': '/tools/buildbot/bin/python'} 06:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:04 INFO - Downloading/unpacking psutil>=3.1.1 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:04 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 06:54:04 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 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:06 INFO - Installing collected packages: psutil 06:54:06 INFO - Running setup.py install for psutil 06:54:06 INFO - building 'psutil._psutil_linux' extension 06:54:06 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 06:54:06 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 06:54:06 INFO - building 'psutil._psutil_posix' extension 06:54:06 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 06:54:06 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 06:54:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:07 INFO - Successfully installed psutil 06:54:07 INFO - Cleaning up... 06:54:07 INFO - Return code: 0 06:54:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:54:07 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')]} 06:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:07 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')]} 06:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:07 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:07 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 06:54:07 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 06:54:07 INFO - Using env: {'DISPLAY': ':0', 06:54:07 INFO - 'HOME': '/home/cltbld', 06:54:07 INFO - 'LANG': 'en_US.UTF-8', 06:54:07 INFO - 'LANGUAGE': 'en_US:en', 06:54:07 INFO - 'LOGNAME': 'cltbld', 06:54:07 INFO - 'MAIL': '/var/mail/cltbld', 06:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:07 INFO - 'MOZ_NO_REMOTE': '1', 06:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:07 INFO - 'NO_EM_RESTART': '1', 06:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:07 INFO - 'PWD': '/builds/slave/test', 06:54:07 INFO - 'SHELL': '/bin/bash', 06:54:07 INFO - 'SHLVL': '1', 06:54:07 INFO - 'TERM': 'linux', 06:54:07 INFO - 'TMOUT': '86400', 06:54:07 INFO - 'USER': 'cltbld', 06:54:07 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:07 INFO - '_': '/tools/buildbot/bin/python'} 06:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:54:07 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 06:54:07 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 06:54:07 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 06:54:07 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 06:54:07 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 06:54:07 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 06:54:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:54:10 INFO - Installing collected packages: mozsystemmonitor 06:54:10 INFO - Running setup.py install for mozsystemmonitor 06:54:10 INFO - Successfully installed mozsystemmonitor 06:54:10 INFO - Cleaning up... 06:54:10 INFO - Return code: 0 06:54:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:54:10 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')]} 06:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:10 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')]} 06:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:10 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 06:54:10 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 06:54:10 INFO - Using env: {'DISPLAY': ':0', 06:54:10 INFO - 'HOME': '/home/cltbld', 06:54:10 INFO - 'LANG': 'en_US.UTF-8', 06:54:10 INFO - 'LANGUAGE': 'en_US:en', 06:54:10 INFO - 'LOGNAME': 'cltbld', 06:54:10 INFO - 'MAIL': '/var/mail/cltbld', 06:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:10 INFO - 'MOZ_NO_REMOTE': '1', 06:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:10 INFO - 'NO_EM_RESTART': '1', 06:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:10 INFO - 'PWD': '/builds/slave/test', 06:54:10 INFO - 'SHELL': '/bin/bash', 06:54:10 INFO - 'SHLVL': '1', 06:54:10 INFO - 'TERM': 'linux', 06:54:10 INFO - 'TMOUT': '86400', 06:54:10 INFO - 'USER': 'cltbld', 06:54:10 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:10 INFO - '_': '/tools/buildbot/bin/python'} 06:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:10 INFO - Downloading/unpacking jsonschema==2.5.1 06:54:10 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 06:54:10 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 06:54:10 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 06:54:10 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 06:54:10 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 06:54:10 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 06:54:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:12 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 06:54:12 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 06:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:13 INFO - warning: no files found matching '*.txt' 06:54:13 INFO - no previously-included directories found matching 'build' 06:54:13 INFO - no previously-included directories found matching 'dist' 06:54:13 INFO - no previously-included directories found matching '.git*' 06:54:13 INFO - Installing collected packages: jsonschema, functools32 06:54:13 INFO - Running setup.py install for functools32 06:54:13 INFO - warning: no files found matching '*.txt' 06:54:13 INFO - no previously-included directories found matching 'build' 06:54:13 INFO - no previously-included directories found matching 'dist' 06:54:13 INFO - no previously-included directories found matching '.git*' 06:54:13 INFO - Successfully installed jsonschema functools32 06:54:13 INFO - Cleaning up... 06:54:13 INFO - Return code: 0 06:54:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:54:13 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')]} 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 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')]} 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:13 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 06:54:13 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 06:54:13 INFO - Using env: {'DISPLAY': ':0', 06:54:13 INFO - 'HOME': '/home/cltbld', 06:54:13 INFO - 'LANG': 'en_US.UTF-8', 06:54:13 INFO - 'LANGUAGE': 'en_US:en', 06:54:13 INFO - 'LOGNAME': 'cltbld', 06:54:13 INFO - 'MAIL': '/var/mail/cltbld', 06:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:13 INFO - 'MOZ_NO_REMOTE': '1', 06:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:13 INFO - 'NO_EM_RESTART': '1', 06:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:13 INFO - 'PWD': '/builds/slave/test', 06:54:13 INFO - 'SHELL': '/bin/bash', 06:54:13 INFO - 'SHLVL': '1', 06:54:13 INFO - 'TERM': 'linux', 06:54:13 INFO - 'TMOUT': '86400', 06:54:13 INFO - 'USER': 'cltbld', 06:54:13 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:13 INFO - '_': '/tools/buildbot/bin/python'} 06:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:54:13 INFO - Cleaning up... 06:54:13 INFO - Return code: 0 06:54:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54:13 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')]} 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 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')]} 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:13 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 06:54:13 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 06:54:13 INFO - Using env: {'DISPLAY': ':0', 06:54:13 INFO - 'HOME': '/home/cltbld', 06:54:13 INFO - 'LANG': 'en_US.UTF-8', 06:54:13 INFO - 'LANGUAGE': 'en_US:en', 06:54:13 INFO - 'LOGNAME': 'cltbld', 06:54:13 INFO - 'MAIL': '/var/mail/cltbld', 06:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:13 INFO - 'MOZ_NO_REMOTE': '1', 06:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:13 INFO - 'NO_EM_RESTART': '1', 06:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:13 INFO - 'PWD': '/builds/slave/test', 06:54:13 INFO - 'SHELL': '/bin/bash', 06:54:13 INFO - 'SHLVL': '1', 06:54:13 INFO - 'TERM': 'linux', 06:54:13 INFO - 'TMOUT': '86400', 06:54:13 INFO - 'USER': 'cltbld', 06:54:13 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:13 INFO - '_': '/tools/buildbot/bin/python'} 06:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:13 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 06:54:13 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 06:54:13 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 06:54:13 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 06:54:13 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 06:54:13 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 06:54:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:15 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 06:54:15 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 06:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:16 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 06:54:16 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 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:16 INFO - Downloading docopt-0.6.1.tar.gz 06:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:16 INFO - Running setup.py install for blobuploader 06:54:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:16 INFO - Running setup.py install for requests 06:54:16 INFO - Running setup.py install for docopt 06:54:17 INFO - Successfully installed blobuploader requests docopt 06:54:17 INFO - Cleaning up... 06:54:17 INFO - Return code: 0 06:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:17 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')]} 06:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:17 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')]} 06:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:17 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:17 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 06:54:17 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 06:54:17 INFO - Using env: {'DISPLAY': ':0', 06:54:17 INFO - 'HOME': '/home/cltbld', 06:54:17 INFO - 'LANG': 'en_US.UTF-8', 06:54:17 INFO - 'LANGUAGE': 'en_US:en', 06:54:17 INFO - 'LOGNAME': 'cltbld', 06:54:17 INFO - 'MAIL': '/var/mail/cltbld', 06:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:17 INFO - 'MOZ_NO_REMOTE': '1', 06:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:17 INFO - 'NO_EM_RESTART': '1', 06:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:17 INFO - 'PWD': '/builds/slave/test', 06:54:17 INFO - 'SHELL': '/bin/bash', 06:54:17 INFO - 'SHLVL': '1', 06:54:17 INFO - 'TERM': 'linux', 06:54:17 INFO - 'TMOUT': '86400', 06:54:17 INFO - 'USER': 'cltbld', 06:54:17 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:17 INFO - '_': '/tools/buildbot/bin/python'} 06:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:17 INFO - Running setup.py (path:/tmp/pip-mtZJE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:17 INFO - Running setup.py (path:/tmp/pip-utc4zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:17 INFO - Running setup.py (path:/tmp/pip-efxkgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:17 INFO - Running setup.py (path:/tmp/pip-jqmXkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:17 INFO - Running setup.py (path:/tmp/pip-Zc1kQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:17 INFO - Running setup.py (path:/tmp/pip-TDkOzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:17 INFO - Running setup.py (path:/tmp/pip-6iacKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:17 INFO - Running setup.py (path:/tmp/pip-QU4E_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:17 INFO - Running setup.py (path:/tmp/pip-sMaZCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:18 INFO - Running setup.py (path:/tmp/pip-O9BeiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:18 INFO - Running setup.py (path:/tmp/pip-2Fe_k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:18 INFO - Running setup.py (path:/tmp/pip-Xib88f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:18 INFO - Running setup.py (path:/tmp/pip-F18mM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:18 INFO - Running setup.py (path:/tmp/pip-WRCBjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:18 INFO - Running setup.py (path:/tmp/pip-qHJfs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:18 INFO - Running setup.py (path:/tmp/pip-Ntav95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:18 INFO - Running setup.py (path:/tmp/pip-PpTnSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:18 INFO - Running setup.py install for manifestparser 06:54:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:54:18 INFO - Running setup.py install for mozcrash 06:54:18 INFO - Running setup.py install for mozdebug 06:54:18 INFO - Running setup.py install for mozdevice 06:54:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Running setup.py install for mozfile 06:54:19 INFO - Running setup.py install for mozhttpd 06:54:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Running setup.py install for mozinfo 06:54:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Running setup.py install for mozInstall 06:54:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Running setup.py install for mozleak 06:54:19 INFO - Running setup.py install for mozlog 06:54:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Running setup.py install for moznetwork 06:54:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Running setup.py install for mozprocess 06:54:19 INFO - Running setup.py install for mozprofile 06:54:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:54:19 INFO - Running setup.py install for mozrunner 06:54:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:54:20 INFO - Running setup.py install for mozscreenshot 06:54:20 INFO - Running setup.py install for moztest 06:54:20 INFO - Running setup.py install for mozversion 06:54:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:54:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:20 INFO - Cleaning up... 06:54:20 INFO - Return code: 0 06:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:20 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:20 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 06:54:20 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 06:54:20 INFO - Using env: {'DISPLAY': ':0', 06:54:20 INFO - 'HOME': '/home/cltbld', 06:54:20 INFO - 'LANG': 'en_US.UTF-8', 06:54:20 INFO - 'LANGUAGE': 'en_US:en', 06:54:20 INFO - 'LOGNAME': 'cltbld', 06:54:20 INFO - 'MAIL': '/var/mail/cltbld', 06:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:20 INFO - 'MOZ_NO_REMOTE': '1', 06:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:20 INFO - 'NO_EM_RESTART': '1', 06:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:20 INFO - 'PWD': '/builds/slave/test', 06:54:20 INFO - 'SHELL': '/bin/bash', 06:54:20 INFO - 'SHLVL': '1', 06:54:20 INFO - 'TERM': 'linux', 06:54:20 INFO - 'TMOUT': '86400', 06:54:20 INFO - 'USER': 'cltbld', 06:54:20 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:20 INFO - '_': '/tools/buildbot/bin/python'} 06:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:20 INFO - Running setup.py (path:/tmp/pip-Q63pyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:20 INFO - Running setup.py (path:/tmp/pip-kdV5PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:20 INFO - Running setup.py (path:/tmp/pip-3A0CIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:20 INFO - Running setup.py (path:/tmp/pip-anVzFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:20 INFO - Running setup.py (path:/tmp/pip-C64Ldd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:20 INFO - Running setup.py (path:/tmp/pip-lHUPRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:21 INFO - Running setup.py (path:/tmp/pip-Jmp0io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:21 INFO - Running setup.py (path:/tmp/pip-VOVLMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:21 INFO - Running setup.py (path:/tmp/pip-jmUDRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:21 INFO - Running setup.py (path:/tmp/pip-X94nH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:21 INFO - Running setup.py (path:/tmp/pip-d8lVgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:21 INFO - Running setup.py (path:/tmp/pip-NO71jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:21 INFO - Running setup.py (path:/tmp/pip-vx0td2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:21 INFO - Running setup.py (path:/tmp/pip-_ZtiUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:21 INFO - Running setup.py (path:/tmp/pip-lVkmqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:21 INFO - Running setup.py (path:/tmp/pip-qZgdVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:21 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)) 06:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:21 INFO - Running setup.py (path:/tmp/pip-B_fxN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:21 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)) 06:54:21 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)) 06:54:21 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)) 06:54:21 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)) 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:21 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 06:54:21 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 06:54:21 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 06:54:21 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 06:54:21 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 06:54:21 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 06:54:23 INFO - Downloading blessings-1.6.tar.gz 06:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:23 INFO - Installing collected packages: blessings 06:54:23 INFO - Running setup.py install for blessings 06:54:24 INFO - Successfully installed blessings 06:54:24 INFO - Cleaning up... 06:54:24 INFO - Return code: 0 06:54:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:24 INFO - Reading from file tmpfile_stdout 06:54:24 INFO - Current package versions: 06:54:24 INFO - argparse == 1.2.1 06:54:24 INFO - blessings == 1.6 06:54:24 INFO - blobuploader == 1.2.4 06:54:24 INFO - docopt == 0.6.1 06:54:24 INFO - functools32 == 3.2.3-2 06:54:24 INFO - jsonschema == 2.5.1 06:54:24 INFO - manifestparser == 1.1 06:54:24 INFO - mozInstall == 1.12 06:54:24 INFO - mozcrash == 1.0 06:54:24 INFO - mozdebug == 0.1 06:54:24 INFO - mozdevice == 0.49 06:54:24 INFO - mozfile == 1.2 06:54:24 INFO - mozhttpd == 0.7 06:54:24 INFO - mozinfo == 0.9 06:54:24 INFO - mozleak == 0.1 06:54:24 INFO - mozlog == 3.4 06:54:24 INFO - moznetwork == 0.27 06:54:24 INFO - mozprocess == 0.25 06:54:24 INFO - mozprofile == 0.28 06:54:24 INFO - mozrunner == 6.13 06:54:24 INFO - mozscreenshot == 0.1 06:54:24 INFO - mozsystemmonitor == 0.3 06:54:24 INFO - moztest == 0.8 06:54:24 INFO - mozversion == 1.4 06:54:24 INFO - psutil == 3.1.1 06:54:24 INFO - requests == 1.2.3 06:54:24 INFO - wsgiref == 0.1.2 06:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:24 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')]} 06:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 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')]} 06:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:24 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 06:54:24 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 06:54:24 INFO - Using env: {'DISPLAY': ':0', 06:54:24 INFO - 'HOME': '/home/cltbld', 06:54:24 INFO - 'LANG': 'en_US.UTF-8', 06:54:24 INFO - 'LANGUAGE': 'en_US:en', 06:54:24 INFO - 'LOGNAME': 'cltbld', 06:54:24 INFO - 'MAIL': '/var/mail/cltbld', 06:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:24 INFO - 'MOZ_NO_REMOTE': '1', 06:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:24 INFO - 'NO_EM_RESTART': '1', 06:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:24 INFO - 'PWD': '/builds/slave/test', 06:54:24 INFO - 'SHELL': '/bin/bash', 06:54:24 INFO - 'SHLVL': '1', 06:54:24 INFO - 'TERM': 'linux', 06:54:24 INFO - 'TMOUT': '86400', 06:54:24 INFO - 'USER': 'cltbld', 06:54:24 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:24 INFO - '_': '/tools/buildbot/bin/python'} 06:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 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)) 06:54:24 INFO - Cleaning up... 06:54:24 INFO - Return code: 0 06:54:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:54:24 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')]} 06:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 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')]} 06:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 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 0x11df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', '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 06:54:24 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 06:54:24 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 06:54:24 INFO - Using env: {'DISPLAY': ':0', 06:54:24 INFO - 'HOME': '/home/cltbld', 06:54:24 INFO - 'LANG': 'en_US.UTF-8', 06:54:24 INFO - 'LANGUAGE': 'en_US:en', 06:54:24 INFO - 'LOGNAME': 'cltbld', 06:54:24 INFO - 'MAIL': '/var/mail/cltbld', 06:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:24 INFO - 'MOZ_NO_REMOTE': '1', 06:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:24 INFO - 'NO_EM_RESTART': '1', 06:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:24 INFO - 'PWD': '/builds/slave/test', 06:54:24 INFO - 'SHELL': '/bin/bash', 06:54:24 INFO - 'SHLVL': '1', 06:54:24 INFO - 'TERM': 'linux', 06:54:24 INFO - 'TMOUT': '86400', 06:54:24 INFO - 'USER': 'cltbld', 06:54:24 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:24 INFO - '_': '/tools/buildbot/bin/python'} 06:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:54:24 INFO - Cleaning up... 06:54:24 INFO - Return code: 0 06:54:24 INFO - Running post-action listener: _resource_record_post_action 06:54:24 INFO - Running post-action listener: _start_resource_monitoring 06:54:24 INFO - Starting resource monitoring. 06:54:24 INFO - [mozharness: 2017-04-10 13:54:24.855009Z] Finished create-virtualenv step (success) 06:54:24 INFO - [mozharness: 2017-04-10 13:54:24.855478Z] Running install step. 06:54:24 INFO - Running pre-action listener: _resource_record_pre_action 06:54:24 INFO - Running main action method: install 06:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:25 INFO - Reading from file tmpfile_stdout 06:54:25 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:54:25 INFO - Reading from file tmpfile_stdout 06:54:25 INFO - Output received: 06:54:25 INFO - Usage: mozinstall [options] installer 06:54:25 INFO - Options: 06:54:25 INFO - -h, --help show this help message and exit 06:54:25 INFO - -d DEST, --destination=DEST 06:54:25 INFO - Directory to install application into. [default: 06:54:25 INFO - "/builds/slave/test"] 06:54:25 INFO - --app=APP Application being installed. [default: firefox] 06:54:25 INFO - mkdir: /builds/slave/test/build/application 06:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:54:41 INFO - Reading from file tmpfile_stdout 06:54:41 INFO - Output received: 06:54:41 INFO - /builds/slave/test/build/application/firefox/firefox 06:54:41 INFO - Running post-action listener: _resource_record_post_action 06:54:41 INFO - [mozharness: 2017-04-10 13:54:41.727031Z] Finished install step (success) 06:54:41 INFO - [mozharness: 2017-04-10 13:54:41.727304Z] Running run-tests step. 06:54:41 INFO - Running pre-action listener: _resource_record_pre_action 06:54:41 INFO - Running main action method: run_tests 06:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:54:41 INFO - Python 2.7.3 06:54:41 INFO - Return code: 0 06:54:41 INFO - grabbing minidump binary from tooltool 06:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:41 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 0x147a400>, '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 0x147b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147b840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:54:41 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 06:54:41 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 06:54:41 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 06:54:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:54:41 INFO - Return code: 0 06:54:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:54:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:54:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:54:41 INFO - ENV: RUST_BACKTRACE is now 1 06:54:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:54:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 06:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 06:54:41 INFO - Using env: {'DISPLAY': ':0', 06:54:41 INFO - 'HOME': '/home/cltbld', 06:54:41 INFO - 'LANG': 'en_US.UTF-8', 06:54:41 INFO - 'LANGUAGE': 'en_US:en', 06:54:41 INFO - 'LOGNAME': 'cltbld', 06:54:41 INFO - 'MAIL': '/var/mail/cltbld', 06:54:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:54:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:41 INFO - 'MOZ_NO_REMOTE': '1', 06:54:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:41 INFO - 'NO_EM_RESTART': '1', 06:54:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:41 INFO - 'PWD': '/builds/slave/test', 06:54:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:54:41 INFO - 'RUST_BACKTRACE': '1', 06:54:41 INFO - 'SHELL': '/bin/bash', 06:54:41 INFO - 'SHLVL': '1', 06:54:41 INFO - 'TERM': 'linux', 06:54:41 INFO - 'TMOUT': '86400', 06:54:41 INFO - 'USER': 'cltbld', 06:54:41 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834', 06:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:41 INFO - '_': '/tools/buildbot/bin/python'} 06:54:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 06:54:42 INFO - mozversion application_buildid: 20170410124947 06:54:42 INFO - mozversion application_changeset: e428ad55a70464accb5439b1a1285c6f565c17aa 06:54:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:54:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:54:42 INFO - mozversion application_name: Firefox 06:54:42 INFO - mozversion application_remotingname: firefox-dev 06:54:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:54:42 INFO - mozversion application_vendor: Mozilla 06:54:42 INFO - mozversion application_version: 54.0a2 06:54:42 INFO - mozversion platform_buildid: 20170410124947 06:54:42 INFO - mozversion platform_changeset: e428ad55a70464accb5439b1a1285c6f565c17aa 06:54:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:54:42 INFO - mozversion platform_version: 54.0a2 06:54:42 INFO - using testdate: 1491832482 06:54:42 INFO - actual date: 1491832482 06:54:42 INFO - starting webserver on 'localhost:38094' 06:54:42 INFO - SUITE-START | Running 2 tests 06:54:42 INFO - TEST-START | dromaeo_css 06:54:42 INFO - operating with platform_type : linux_ 06:54:42 INFO - Initialising browser for dromaeo_css test... 06:54:42 INFO - TEST-INFO | started process 29152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqZ2bR/profile http://localhost:38094/getInfo.html) 06:54:45 INFO - PROCESS | 29152 | __metrics Screen width/height:1600/1200 06:54:45 INFO - PROCESS | 29152 | colorDepth:24 06:54:45 INFO - PROCESS | 29152 | Browser inner width/height: 1024/697 06:54:45 INFO - PROCESS | 29152 | __metrics 06:54:46 INFO - PROCESS | 29152 | 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" 06:54:46 INFO - PROCESS | 29152 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:54:47 INFO - TEST-INFO | 29152: exit 0 06:54:47 INFO - Browser initialized. 06:54:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:54:47 INFO - TEST-INFO | started process 29245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqZ2bR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:59 INFO - PROCESS | 29245 | RSS: Main: 139657216 06:54:59 INFO - PROCESS | 29245 | 06:58:00 INFO - PROCESS | 29245 | Cycle 1(1): loaded http://localhost:38094/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38094/tests/dromaeo/cssquery-ext.html) 06:58:02 INFO - PROCESS | 29245 | RSS: Main: 276140032 06:58:02 INFO - PROCESS | 29245 | 06:59:49 INFO - PROCESS | 29245 | ************************* 06:59:49 INFO - PROCESS | 29245 | A coding exception was thrown and uncaught in a Task. 06:59:49 INFO - PROCESS | 29245 | 06:59:49 ERROR - PROCESS | 29245 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:59:49 INFO - PROCESS | 29245 | Full stack: 06:59:49 INFO - PROCESS | 29245 | ************************* 06:59:49 INFO - PROCESS | 29245 | ************************* 06:59:49 INFO - PROCESS | 29245 | A coding exception was thrown and uncaught in a Task. 06:59:49 INFO - PROCESS | 29245 | 06:59:49 ERROR - PROCESS | 29245 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:59:49 INFO - PROCESS | 29245 | Full stack: 06:59:49 INFO - PROCESS | 29245 | ************************* 06:59:49 INFO - PROCESS | 29245 | ************************* 06:59:49 INFO - PROCESS | 29245 | A coding exception was thrown and uncaught in a Task. 06:59:49 INFO - PROCESS | 29245 | 06:59:49 ERROR - PROCESS | 29245 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:59:49 INFO - PROCESS | 29245 | Full stack: 06:59:49 INFO - PROCESS | 29245 | ************************* 06:59:49 INFO - PROCESS | 29245 | ************************* 06:59:49 INFO - PROCESS | 29245 | A coding exception was thrown and uncaught in a Task. 06:59:49 INFO - PROCESS | 29245 | 06:59:49 ERROR - PROCESS | 29245 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:59:49 INFO - PROCESS | 29245 | Full stack: 06:59:49 INFO - PROCESS | 29245 | ************************* 07:01:04 INFO - PROCESS | 29245 | Cycle 1(1): loaded http://localhost:38094/tests/dromaeo/cssquery-ext.html (next: http://localhost:38094/tests/dromaeo/cssquery-jquery.html) 07:01:04 INFO - PROCESS | 29245 | RSS: Main: 217960448 07:01:04 INFO - PROCESS | 29245 | 07:04:06 INFO - PROCESS | 29245 | Cycle 1(1): loaded http://localhost:38094/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38094/tests/dromaeo/cssquery-mootools.html) 07:04:07 INFO - PROCESS | 29245 | RSS: Main: 200273920 07:04:07 INFO - PROCESS | 29245 | 07:07:09 INFO - PROCESS | 29245 | Cycle 1(1): loaded http://localhost:38094/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38094/tests/dromaeo/cssquery-prototype.html) 07:07:09 INFO - PROCESS | 29245 | RSS: Main: 176996352 07:07:09 INFO - PROCESS | 29245 | 07:10:12 INFO - PROCESS | 29245 | Cycle 1(1): loaded http://localhost:38094/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38094/tests/dromaeo/cssquery-yui.html) 07:10:13 INFO - PROCESS | 29245 | RSS: Main: 177995776 07:10:13 INFO - PROCESS | 29245 | 07:13:15 INFO - PROCESS | 29245 | Cycle 1(1): loaded http://localhost:38094/tests/dromaeo/cssquery-yui.html (next: http://localhost:38094/tests/dromaeo/cssquery-dojo.html) 07:13:16 INFO - PROCESS | 29245 | RSS: Main: 263081984 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | __start_tp_report 07:13:16 INFO - PROCESS | 29245 | _x_x_mozilla_page_load 07:13:16 INFO - PROCESS | 29245 | _x_x_mozilla_page_load_details 07:13:16 INFO - PROCESS | 29245 | |i|pagename|runs| 07:13:16 INFO - PROCESS | 29245 | |0;dojo.html;3369.5451114099596;3375.088726043967;3400.778949368291;3427.982860085699;3448.7930724156536;5751.539876809856;5831.416858314172;5837.7373018214175;5844.035734103873;5858.648481091127;5882.441168089035;5887.4406931341455;5935.376785437532;5941.762329506825;5962.493188079007;5360.731963401824;5365.812196573121;5393.568514518829;5409.080456322415;5481.890362192754;5147.7426128693605;5168.043911876296;5448.210009548613;5457.045017122007;5457.590680698963;5240.475952404748;5321.281626980347;5332.173513105475;5408.594355423339;5437.510624043835;5417.864553386177;5440.401555828856;5447.754851031674;5447.809326673587;5449.291592093042;5342.572594192456;5346.438623944468;5358.303420555342;5393.568514518868;5415.323084614423;5592.356878958891;5613.410591887834;5730.19777231188;5791.305043394777;5791.594588378815;6317.905231421532;6317.905231421532;6319.33646967071;6319.6524191169465;6320.399562041599;6315.084312774622;6347.238331400262;6350.079238510436;6352.936470635281;6354.078658594524;5554.166874968787;5554.694491802949;5796.507296879812;5837.737301821428;5907.14346419771;6404.135441715402;6437.259715132726;6459.450946669585;6464;6464.547481676237;6196.1015652731;6203.937960620336;6203.96898015507;6206.131141640174;6207.472364848948;5879.794207202727;5979.521638268928;6147.231596050494;6292.05619157121;6299.149614802035;6271.341509141565;6275.6862156891975;6275.6862156891975;6282.277538083087;6283.654399008007;6000.429959153874;6010.639361638316;6037.72830222641;6287.59130656515;6290.968545157245;4643.048175124091;4676.321933319649;4691.437027556715;4691.62467002639;4704.95295047052;4120.8145633445965;4122.319817230124;4222;4232.111256636079;4266.424032755538;5869.853253668693;5883.470487656132;5989.55078369124;5993.430624090704;5994.730237139339;6188.257409110845;6243.375662433811;6247.96876015617;6248.375162483715;6251.59364641306;5957.285125784847;5961.850953726105;5966.134910437962;5981.850453738604;5988.520918326523;5127.025865085622;5165.225216217597;5267.209918512254;5298.205269209572;5332.093544097513;6568.540202185896;6572.638504882278;6577.4409175218725;6583.177102862142;6586.73653053882;6270.905936411049;6375;6376.139221205078;6383.585066970632;6397.6481293529305;6150.907736384047;6209.410106039919;6422.518311126591;6562.868742625216;6579.2104947406615;6240.500759939285;6271.059341098871;6277.183966084563;6277.811665650038;6282.308946016026;6367.490600751836;6380.266269379081;6385.010323399881;6385.425311721781;6389.9361006389345;5862.706864656665;5896.528277737685;6143.56995010345;6195.132681424514;6215.223097112861;6090.847728806815;6091.086337049478;6147.631142131487;6209.316975132822;6214.067889816563;6174.907376389448;6187.319394866651;6192.442680158807;6193.009118541012;6199.473044791243;5871.295444546682;5884.941150588611;6037.516998640011;6195.566310358412;6232.376762323732;5894.587378883437;5948.851278717893;5973.761049557969;5990.7903223386975;5992.700364981821 07:13:16 INFO - PROCESS | 29245 | |1;ext.html;720.394868310619;791.6912404162376;808.0626473290981;877.749841295231;894.4588523943011;29641.703582964165;41561.58438415615;42376.57623423765;42422.57577424225;42652;44835.551644483545;44921;45050;45114.77442612791;45151.83937124402;7457.664405101784;7642.847143057135;9070.319726020558;9194.908050919506;9205.171534561889;10396.896031039707;10606.257561970666;11042.723931901686;11043.061339786127;11058.502367393447;10762.246642735012;10809.567617295337;10813;10821;10835;10673.519691613896;10724.463776811168;10728.195385346053;10728.678139655824;10746.086582640406;10381.42902140382;10407.115395191418;10426.113780328606;10434.686959391154;10435.843462348072;41751;41753;41889;41937.37093943563;42136.78931605353;4115.9588404115875;4179.791010449465;4182.121754431573;4254.74471531706;4313.266744653385;29645.100189412864;30228.395432091456;30237.69762302371;30635.234119146975;31539;4311.267084595626;4332.956670433318;4349.304111342201;4352.978235108836;4436.55634436557;228738;229551.99999999834;230001;230124;230344;51303.486965130614;51513.484865150866;51519.22721159185;51565.742171288905;51660.22509662358;54188.72905635447;54244;54265.1860222097;54279.72860135674;54337.18494222511;16200.75698864518;16386.26261818221;16394.426195083353;16411;16511.83488165103;13036.608901732963;13394.129381590361;14471.276436178148;14624.634384140269;14637.560873173821;13080.803787943189;13159.736805263841;13187.736245275233;13194.076414650883;13318;5564.27664403633;5579.13523403873;5624.803131890364;5702.201691763156;5755.165501002331;1017.6082208349839;1019.6278358399279;1030.0832259289239;1031.2214278219897;1036.828923227659;27341.90632374683;28723;28813.711862881522;29089;29191;1256.1772039314264;1267.0876968582606;1269.8412698412699;1291.3672300572653;1307.6403988903128;13260.138091024246;13570.117942333914;13611.319434028457;13682.52111176124;13857.514986975408;330914;331714;332960;333582;336004;45340;45816.312755308696;45890.311645325346;45984.3102353465;45996.770016150374;1488.3153749275455;1515.2272341106116;1515.3786947351532;1538.538438468455;1541.6608346163825;23998.2483030431;24870.63211523311;25345.87327063353;25419.36451588651;25444.491110178064;36157.638423615426;36181.457278140326;36255.81872090622;36280.63719362878;36289.818550907075;295863;296831;296923;297154;298561;24231.273061808173;24756.876215618806;27176.320591985357;27843.721562784922;28713;36871;36918.26163476662;36970;37220.81389593035;37486;28679.42641147207;28737.85631071831;29002.564961526015;29063.709362906946;29469.852650737466;28763.137105886857;29228.26929326784;29261.268468288465;29394.412111758073;29742.10773676793;32793.18017049593;32835.34329313448;33059.504107437926;35238.647613523535;36132.09669758277;28583.571246430904;28806.42387152287;29420.852895735385;29474.263143421587;29710.554341685325;24269.514609707352;24413.877930610233;24619.38451538654;24771;27222.863885680446 07:13:16 INFO - PROCESS | 29245 | |2;jquery.html;452.09355242738303;465.19521228275084;466.0701899710079;479.5204795204795;490.1765034741634;19635.60728785425;21229.150833966643;21665.891670541645;21678;21993.450163745914;22335.888320558413;22536;22879;22922.885385573092;23075.76924230757;6610.338966103399;6627.569208001489;6809.387155156035;6865.450763938873;6915.861682766342;6795.252522222576;6908.516403851732;6908.827279318032;6909.585424874524;7173.354398104169;7615.5811430371305;7649.08211014679;7655.617219139049;7665.156832748393;7669.156392796788;7183.604901730403;7441;7465.514741541782;7492.400607951406;7663.885041724378;7158.677859496283;7328.9267107329315;7378.889316660255;7422.072240969879;7435.033445652085;24830;25174.622380664303;25210.747892521205;25304.367390815194;25381.238562843144;3065.432894914448;3074.707902749235;3199.2481766784786;3202.9359412811614;3379.1721028347965;15454.304556294881;16111.194440277939;16207.432739854166;16552.917235413865;16585.83414165855;2244.0350649220827;2256.3569382725846;2304.43541332373;2344.179537161997;2348.495073559176;117978.4101079489;121761;121822;122189.77810221873;123278;17465.650686986188;18249.543761405806;18552;18571.907140464213;18855.434336969913;31182.844085779427;31486.212844679067;31556.211094722355;31679;31787.523187152212;10539.003130833615;10628.787424251626;10653.147748180127;10872.130229581615;10943.781124377627;9056.683016094537;9058.637654493747;9107.08929107084;9112.179903808688;9284.442933424016;9101.317401194805;9365;9481.905180948102;9496.715098547054;9614.615415383447;3804.885853424402;3832.405977073558;3869.613038696164;3973.2252210819192;4048.919021619551;940.4592359393239;941.7457286532734;949.2880339745191;951.4053716427233;960.851068084448;20224;21530.354089377342;21725.91370431472;21811.34565962992;22065;953.270747877874;955.2835373469898;958.4249450329886;967.6468089147411;971.844504879216;11327.433628318551;11651.242669226473;11879.22785018971;11887.524499020115;11909.166358354832;462855;465911;653870;700766;704600;107663;124346;124600;126704;127719;1306.6014865465934;1327.3164320375015;1390.4368730663896;1390.9443622254996;1394.4352537222442;19117.71323430122;19182.808171918103;19553.70669439988;19554.21783128716;19559;51083;51361.7431912853;52118;52942.73528632486;53085;67773;68592.6570367145;69250.65374673094;70153;70429;10886.212546468949;11221;11524.942375288405;11629.069674425857;12145.271283723005;13987.300634968007;14022.509212177525;14373.425062997363;14702.55892323232;14765.261736913326;12654.87345126537;12861.614151575468;12887.80668289995;12943.09398342107;12958.28729419891;11003.394813285346;11064.391458469861;11177.964038535316;11189.608363707232;11266.098712102848;12504.937475312565;13051.21692698441;13155.60533184006;13170.670733231362;13541.59375218745;12478.18891772032;12567.497300107892;12594.559190428292;12604.24374537494;12611.684707882376;11843.650226590406;12538.498460061495;12695.55565555201;13007.284599347127;13350.666233344244 07:13:16 INFO - PROCESS | 29245 | |3;mootools.html;1378.0422606288632;1522.4214798376615;1522.7868098466215;1527.969440611187;1538.523057852066;9265.90734092659;11238;11605.941970290147;11990.40047997601;12031.639050828468;11671.766564668702;11750.647480575597;11793.056555475563;11794.528218871257;11795.174337796358;2071.2025870040065;2128.5849259394427;2436.6466862304956;2457.8402403843784;2497.1509686706518;2464.5687004774095;2495.7629025242572;2507.5486412445753;2510.1089113364765;2510.585753350704;2279.3389916924157;2290.518991011881;2291.140822191678;2296.701428814252;2304.654301854727;2348.9060437582475;2360.103160798894;2368.8697121658215;2368.928932132039;2452.4849781545895;2448.9142879999295;2473.5423946569763;2473.849659908133;2475.5420247254315;2479.8636075015866;11868.228565143325;11962.222455540363;11968.521259149624;11976.580819671357;11992.940035299855;6068.180795592582;6118.235220597426;6180.9381906180815;6185.165002724664;6187;3439.501272315525;3470.548828652284;3543.539339885824;3692.2615476904457;3696.9260614787822;1372.7940808878648;1418.4751641892462;1479.1864474539068;2297.1615360393503;2364.9172278970154;17750.733738993924;17855.464336069937;17868;17882.731759023623;17897.46307610774;5082.237664350377;5098.745062746922;5148.2020286855595;5260.789568417297;5312.628116031918;12918.547850825364;13432.19406835593;13453.529126480526;13456.327183640975;13473.595792126252;6215.9378406216265;6226.377362263737;6239.157713708682;6240.500759939194;6245.18812554365;5635.436456354331;5640.379558248589;5644.294463192101;5689.402612725604;5698.430156984268;4002;4145.689073319513;4195.370694395804;4237.110206856594;4258.190943720683;1102.1513434655271;1103.779244151173;1111.9110471162287;1127.7180704823795;1133.0425790207262;866.4151697604092;870.8780770692108;890.9465432074096;930.283681565191;1093.753905371301;7457.515261507984;7569;7584.772456826304;7603.0876294843865;7825.060992680915;1058.6241884131177;1073.7798751255973;1083.6369816111692;1115.5816568786704;1135.3755434510986;4695.7886895089805;4818.277258411266;4831.202851529459;4976.576990955809;5016.097102521581;14520.782188267185;14873.925630371996;14879;14881.181535015678;14891.957562970489;14501.202433866029;14613.415463381558;14645.780313295309;14714.852851471562;14793.556193314218;10792.568297268179;10959.342439453658;11031.779364412827;11082;11123.777524449466;7381.929620205147;7501.249875012455;7631.275028872248;7645.159032506531;7648.311651951351;13094.952403807481;13175.802362964372;13194.274314912773;13236.801447978096;13285.800712989507;10616.203784716332;12721.93639031799;13451.415000989433;13649.181049137083;13770.24263665508;9328.95335523318;9441.197498212729;9536.952315238379;9546.85679714791;9550.808983820423;11083.61207357771;11123.165762568002;11128.221024528206;11262.38056906878;11297.378644174649;9440.244780417688;9444.802778466881;9557.952210238904;9670.081342272755;9878.950605246928;9229.907700923173;9349.158575728217;9412.717618471457;9506.096920792514;9646.951765241129;8722;8736.650533978824;8843.955780221058;8846.292296616384;8852.468851868909;6227.564070515021;6285.465735412541;6319.304876463677;6347.333529979285;6403.0715546246465;6436.227652681709;6474.420634054962;6525.804225873231;6543.443807276435;6563.0811686364905 07:13:16 INFO - PROCESS | 29245 | |4;prototype.html;410.62222755065335;423.47700589771625;426.98292068317267;436.6332280884057;440.47803353026666;5128.256402821593;5193.5325820676135;5210.687358758477;5277.736113194334;5287.180487024508;5079.212722028083;5158.561522270602;5200.947990520093;5230.450802665722;5260;4352.912941741163;4366.759828209447;4379.9781001095025;4404.427424434819;4432.7118737282135;4444.888877778065;4456.17560751262;4469.955300447003;4475.865724028285;4479.641628669715;4237.389791879082;4379.627731642814;4427.645788336926;4430.401895744066;4443.866683999469;4383.649308055348;4386.276264416368;4398.406215160944;4400.515943246241;4401.779911004453;4150.232207041707;4161.461508479825;4171.290880550314;4179.874603761861;4192.496900371944;4917.901641967141;5053.444121146707;5079.415867175285;5127.512886275797;5199.896002079975;5044.369453818273;5082.678503589056;5084.339035925306;5108.4125325587665;5119.513646203604;5466.480684334982;5502.284702988626;5507.421720719347;5549.556035517149;5551.1673249012565;4366.5851744084575;4544.455324846592;4552.4764652065105;4563.452385713736;4597.563231493036;5424.647397919122;5553.305836770403;5612.270404847343;5651.9152212716845;5700.914486282709;4677.695949763254;4677.8773094457765;4705.905881882343;4708.270218116198;4715.882102947454;4529.773511324421;4623.722576645412;4667.183242932541;4772.880677983008;4779.569838714532;4954.860382112134;4990.50094990498;5022.949770502321;5030.622703297267;5043.722595257223;5400.189971504227;5459.945400545944;5489.313835770528;5490.533304669068;5518.751656175482;1564.319521008365;1606.253092312057;1625.4473479016954;1630.6086539230498;1649.3897258014372;1246.4391024039037;1253.921627400435;1256.836611240551;1275.2029981261712;1276.8827276133384;5255.211718242218;5288.180332048539;5326.975749215351;5348.839534813962;5361.356637203483;5573.219749235111;5602.243697100839;5631.267935168402;5651.519620832275;5665.9716701417055;5067.442581316052;5371.811986580529;5390.4879036491475;5392.355331623892;5418.756155972991;2913.533834586456;2966.9406611867644;2976.1666733314705;2986.7013298670395;3006.669266380696;5625.521830644359;5716.771329146787;5838.8540286492325;5852.941470585325;5914.112883067574;5718.342390625048;5720.141978703145;5723.399043100415;5727.856803579861;5728.911506813692;5747.339056008613;5761.251037365199;5765.971170144123;5770.682612456355;5771;5370.9731451342495;5532.30846144232;5585.151572698034;5599.348192283368;5606.327240731139;5298.8940221196135;5409.594280428905;5453.863653408538;5531.640443371329;5537.667739935617;5734.799282025109;5775.372205646505;5792.420757924174;5797.76808927655;5804.6807425590305;4558.427342566809;4607.825004623799;4627.93058104122;4737;4755.574656924924;5586.581006424453;5615.241942337895;5615.522680572197;5645.633033852787;5648.6840395437675;5469.589780766538;5470.781168753205;5482.23248745184;5502.9174562380795;5514.228008078792;5299.463155684808;5431.646942948696;5449.945500544944;5469.589780766538;5528.281323427928;5457.717436402521;5457.808976685797;5473.616846820684;5484.287042684585;5495.203195536705;5444.183372494158;5456.563474922076;5456.66311753607;5474.233607294902;5497.532709719719;5128.79484820603;5339.733013349394;5340.2256672783005;5351.357837059578;5387.838364849061 07:13:16 INFO - PROCESS | 29245 | |5;yui.html;827.5944488430112;837.1335667584052;911.9863202051969;924.1313165624308;937.3204426790576;16581.502554923358;18510.72233916489;18573.814261857377;18584.256629734813;18724.625507489844;15905.602359941007;16138.273777680004;16673.16634168293;16900.83099169008;16909.57726056846;878.1964502480223;890.8218356328761;892.4689809563332;894.8299823033602;895.3106108296607;882.7969566999594;884.3102380143466;884.849575572151;885.0706757904208;885.1325700813206;910.4127837544779;913.6025828764475;914.2092090341839;916.0335845682802;916.1571354353977;905.2848249882585;905.8097799462088;912.2565109435789;913.4427998920653;914.3234006834961;668.1180841289499;668.906353110565;669.8459354348479;670.0083875863701;670.0251134599147;16431.096289704063;16759.413420530345;17227.827721722748;17281.740773888403;17317.393891213873;16117.645889055659;16350.427735029218;16539.173041347884;16638.168091595373;16643.33426662932;13450;13555.525556605471;13658;13765.38055787482;13798.517051903236;3979.6617287530594;3987.2424239394422;4011.8796436106963;4073.8370465181356;4128.298189307795;46073.76963115163;60313.39686603165;77785.22214777893;78812;80009.19990800133;12608.81086783699;12922.353882305848;12968.481260749464;12987.805182922264;12997.350132493337;22952.4261893454;23016.65475017876;23044;23082.8845855773;23324.41688957756;9195.080491950752;9285.210757085724;9345.672901448417;9401.482918439415;9420.717378478657;4983.775730092155;5044.672096313801;5059.519345662156;5079.2381142828135;5176.016556854186;3681.7238707097076;3743.6630703236838;3763.5483741951143;3778.7543809652284;3813.618638136164;638.8945823939091;640.4204195203348;647.5596594315816;647.5920170292685;650.0249625561657;846.7121178799238;848.2577744473585;868.3617541107282;873.1486800369589;885.8582626779685;11648.592299269485;11735.589254376056;11927.1650984432;12340.629781106582;12383.938080309541;659.7295109005285;661.8808614449446;675.8817206988757;723.2731105239201;869.1265278395173;5299.894002119936;5485.6982865942755;5580.91628625571;5618.943810561842;5653.321601407857;74040.25959740333;74769.80473090884;75976.62011689907;76098;77345.61327193328;66047.66976165089;66272;66680.6665966667;69680.3031969684;69848.59179433143;60380;61053.694731526055;62744.05883911654;63430.68284658547;63903.36096639067;11077;11169.385683787144;11294.096472282363;11384.37385943781;11470.369129697612;37606.62393376031;39537.80231098826;41217.1756564873;42096.3685544711;42989;49357;49722;50121;50971.74514127554;52346;12630.494780208688;12865.163764355288;12867.549635762703;13009.479620815062;13233.073684842353;15245.771313430529;15335.693286134438;15914.363425463314;16033.198340083183;16208.594785129995;14816.333265003317;15324.463643772415;15353.923230383776;17350.219240134476;17504.387346443324;16126.67746645037;16261.349546018027;17291.221895015005;17338.653226935643;17430;15087.245637717851;15370.769438458208;15517.45688900883;15705.13621750769;16026.759598605797;11439.485223164811;11461.197716160123;11554.826677599674;11691.590794322157;11977;13253.933730331286;13630.318484075558;13764.314042777054;13859.445622175403;14146.363413646617 07:13:16 INFO - PROCESS | 29245 | __end_tp_report 07:13:16 INFO - PROCESS | 29245 | __start_cc_report 07:13:16 INFO - PROCESS | 29245 | _x_x_mozilla_cycle_collect,1328 07:13:16 INFO - PROCESS | 29245 | __end_cc_report 07:13:16 INFO - PROCESS | 29245 | __startTimestamp1491833596169__endTimestamp 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | ------- Summary: start ------- 07:13:16 INFO - PROCESS | 29245 | Number of tests: 6 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | [#0] dojo.html Cycles:165 Average:5817.12 Median:5990.79 stddev:678.00 (11.3%) stddev-sans-first:652.32 07:13:16 INFO - PROCESS | 29245 | Values: 3369.5 3375.1 3400.8 3428.0 3448.8 5751.5 5831.4 5837.7 5844.0 5858.6 5882.4 5887.4 5935.4 5941.8 5962.5 5360.7 5365.8 5393.6 5409.1 5481.9 5147.7 5168.0 5448.2 5457.0 5457.6 5240.5 5321.3 5332.2 5408.6 5437.5 5417.9 5440.4 5447.8 5447.8 5449.3 5342.6 5346.4 5358.3 5393.6 5415.3 5592.4 5613.4 5730.2 5791.3 5791.6 6317.9 6317.9 6319.3 6319.7 6320.4 6315.1 6347.2 6350.1 6352.9 6354.1 5554.2 5554.7 5796.5 5837.7 5907.1 6404.1 6437.3 6459.5 6464.0 6464.5 6196.1 6203.9 6204.0 6206.1 6207.5 5879.8 5979.5 6147.2 6292.1 6299.1 6271.3 6275.7 6275.7 6282.3 6283.7 6000.4 6010.6 6037.7 6287.6 6291.0 4643.0 4676.3 4691.4 4691.6 4705.0 4120.8 4122.3 4222.0 4232.1 4266.4 5869.9 5883.5 5989.6 5993.4 5994.7 6188.3 6243.4 6248.0 6248.4 6251.6 5957.3 5961.9 5966.1 5981.9 5988.5 5127.0 5165.2 5267.2 5298.2 5332.1 6568.5 6572.6 6577.4 6583.2 6586.7 6270.9 6375.0 6376.1 6383.6 6397.6 6150.9 6209.4 6422.5 6562.9 6579.2 6240.5 6271.1 6277.2 6277.8 6282.3 6367.5 6380.3 6385.0 6385.4 6389.9 5862.7 5896.5 6143.6 6195.1 6215.2 6090.8 6091.1 6147.6 6209.3 6214.1 6174.9 6187.3 6192.4 6193.0 6199.5 5871.3 5884.9 6037.5 6195.6 6232.4 5894.6 5948.9 5973.8 5990.8 5992.7 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | [#1] ext.html Cycles:180 Average:44331.35 Median:29445.35 stddev:75823.53 (257.5%) stddev-sans-first:75965.53 07:13:16 INFO - PROCESS | 29245 | Values: 720.4 791.7 808.1 877.7 894.5 29641.7 41561.6 42376.6 42422.6 42652.0 44835.6 44921.0 45050.0 45114.8 45151.8 7457.7 7642.8 9070.3 9194.9 9205.2 10396.9 10606.3 11042.7 11043.1 11058.5 10762.2 10809.6 10813.0 10821.0 10835.0 10673.5 10724.5 10728.2 10728.7 10746.1 10381.4 10407.1 10426.1 10434.7 10435.8 41751.0 41753.0 41889.0 41937.4 42136.8 4116.0 4179.8 4182.1 4254.7 4313.3 29645.1 30228.4 30237.7 30635.2 31539.0 4311.3 4333.0 4349.3 4353.0 4436.6 228738.0 229552.0 230001.0 230124.0 230344.0 51303.5 51513.5 51519.2 51565.7 51660.2 54188.7 54244.0 54265.2 54279.7 54337.2 16200.8 16386.3 16394.4 16411.0 16511.8 13036.6 13394.1 14471.3 14624.6 14637.6 13080.8 13159.7 13187.7 13194.1 13318.0 5564.3 5579.1 5624.8 5702.2 5755.2 1017.6 1019.6 1030.1 1031.2 1036.8 27341.9 28723.0 28813.7 29089.0 29191.0 1256.2 1267.1 1269.8 1291.4 1307.6 13260.1 13570.1 13611.3 13682.5 13857.5 330914.0 331714.0 332960.0 333582.0 336004.0 45340.0 45816.3 45890.3 45984.3 45996.8 1488.3 1515.2 1515.4 1538.5 1541.7 23998.2 24870.6 25345.9 25419.4 25444.5 36157.6 36181.5 36255.8 36280.6 36289.8 295863.0 296831.0 296923.0 297154.0 298561.0 24231.3 24756.9 27176.3 27843.7 28713.0 36871.0 36918.3 36970.0 37220.8 37486.0 28679.4 28737.9 29002.6 29063.7 29469.9 28763.1 29228.3 29261.3 29394.4 29742.1 32793.2 32835.3 33059.5 35238.6 36132.1 28583.6 28806.4 29420.9 29474.3 29710.6 24269.5 24413.9 24619.4 24771.0 27222.9 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | [#2] jquery.html Cycles:180 Average:36587.15 Median:12613.66 stddev:100862.92 (799.6%) stddev-sans-first:101109.38 07:13:16 INFO - PROCESS | 29245 | Values: 452.1 465.2 466.1 479.5 490.2 19635.6 21229.2 21665.9 21678.0 21993.5 22335.9 22536.0 22879.0 22922.9 23075.8 6610.3 6627.6 6809.4 6865.5 6915.9 6795.3 6908.5 6908.8 6909.6 7173.4 7615.6 7649.1 7655.6 7665.2 7669.2 7183.6 7441.0 7465.5 7492.4 7663.9 7158.7 7328.9 7378.9 7422.1 7435.0 24830.0 25174.6 25210.7 25304.4 25381.2 3065.4 3074.7 3199.2 3202.9 3379.2 15454.3 16111.2 16207.4 16552.9 16585.8 2244.0 2256.4 2304.4 2344.2 2348.5 117978.4 121761.0 121822.0 122189.8 123278.0 17465.7 18249.5 18552.0 18571.9 18855.4 31182.8 31486.2 31556.2 31679.0 31787.5 10539.0 10628.8 10653.1 10872.1 10943.8 9056.7 9058.6 9107.1 9112.2 9284.4 9101.3 9365.0 9481.9 9496.7 9614.6 3804.9 3832.4 3869.6 3973.2 4048.9 940.5 941.7 949.3 951.4 960.9 20224.0 21530.4 21725.9 21811.3 22065.0 953.3 955.3 958.4 967.6 971.8 11327.4 11651.2 11879.2 11887.5 11909.2 462855.0 465911.0 653870.0 700766.0 704600.0 107663.0 124346.0 124600.0 126704.0 127719.0 1306.6 1327.3 1390.4 1390.9 1394.4 19117.7 19182.8 19553.7 19554.2 19559.0 51083.0 51361.7 52118.0 52942.7 53085.0 67773.0 68592.7 69250.7 70153.0 70429.0 10886.2 11221.0 11524.9 11629.1 12145.3 13987.3 14022.5 14373.4 14702.6 14765.3 12654.9 12861.6 12887.8 12943.1 12958.3 11003.4 11064.4 11178.0 11189.6 11266.1 12504.9 13051.2 13155.6 13170.7 13541.6 12478.2 12567.5 12594.6 12604.2 12611.7 11843.7 12538.5 12695.6 13007.3 13350.7 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | [#3] mootools.html Cycles:180 Average:7314.76 Median:2469.06 stddev:4644.32 (188.1%) stddev-sans-first:4635.92 07:13:16 INFO - PROCESS | 29245 | Values: 1378.0 1522.4 1522.8 1528.0 1538.5 9265.9 11238.0 11605.9 11990.4 12031.6 11671.8 11750.6 11793.1 11794.5 11795.2 2071.2 2128.6 2436.6 2457.8 2497.2 2464.6 2495.8 2507.5 2510.1 2510.6 2279.3 2290.5 2291.1 2296.7 2304.7 2348.9 2360.1 2368.9 2368.9 2452.5 2448.9 2473.5 2473.8 2475.5 2479.9 11868.2 11962.2 11968.5 11976.6 11992.9 6068.2 6118.2 6180.9 6185.2 6187.0 3439.5 3470.5 3543.5 3692.3 3696.9 1372.8 1418.5 1479.2 2297.2 2364.9 17750.7 17855.5 17868.0 17882.7 17897.5 5082.2 5098.7 5148.2 5260.8 5312.6 12918.5 13432.2 13453.5 13456.3 13473.6 6215.9 6226.4 6239.2 6240.5 6245.2 5635.4 5640.4 5644.3 5689.4 5698.4 4002.0 4145.7 4195.4 4237.1 4258.2 1102.2 1103.8 1111.9 1127.7 1133.0 866.4 870.9 890.9 930.3 1093.8 7457.5 7569.0 7584.8 7603.1 7825.1 1058.6 1073.8 1083.6 1115.6 1135.4 4695.8 4818.3 4831.2 4976.6 5016.1 14520.8 14873.9 14879.0 14881.2 14892.0 14501.2 14613.4 14645.8 14714.9 14793.6 10792.6 10959.3 11031.8 11082.0 11123.8 7381.9 7501.2 7631.3 7645.2 7648.3 13095.0 13175.8 13194.3 13236.8 13285.8 10616.2 12721.9 13451.4 13649.2 13770.2 9329.0 9441.2 9537.0 9546.9 9550.8 11083.6 11123.2 11128.2 11262.4 11297.4 9440.2 9444.8 9558.0 9670.1 9879.0 9229.9 9349.2 9412.7 9506.1 9647.0 8722.0 8736.7 8844.0 8846.3 8852.5 6227.6 6285.5 6319.3 6347.3 6403.1 6436.2 6474.4 6525.8 6543.4 6563.1 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | [#4] prototype.html Cycles:180 Average:4774.74 Median:5268.87 stddev:1262.93 (24.0%) stddev-sans-first:1223.26 07:13:16 INFO - PROCESS | 29245 | Values: 410.6 423.5 427.0 436.6 440.5 5128.3 5193.5 5210.7 5277.7 5287.2 5079.2 5158.6 5200.9 5230.5 5260.0 4352.9 4366.8 4380.0 4404.4 4432.7 4444.9 4456.2 4470.0 4475.9 4479.6 4237.4 4379.6 4427.6 4430.4 4443.9 4383.6 4386.3 4398.4 4400.5 4401.8 4150.2 4161.5 4171.3 4179.9 4192.5 4917.9 5053.4 5079.4 5127.5 5199.9 5044.4 5082.7 5084.3 5108.4 5119.5 5466.5 5502.3 5507.4 5549.6 5551.2 4366.6 4544.5 4552.5 4563.5 4597.6 5424.6 5553.3 5612.3 5651.9 5700.9 4677.7 4677.9 4705.9 4708.3 4715.9 4529.8 4623.7 4667.2 4772.9 4779.6 4954.9 4990.5 5022.9 5030.6 5043.7 5400.2 5459.9 5489.3 5490.5 5518.8 1564.3 1606.3 1625.4 1630.6 1649.4 1246.4 1253.9 1256.8 1275.2 1276.9 5255.2 5288.2 5327.0 5348.8 5361.4 5573.2 5602.2 5631.3 5651.5 5666.0 5067.4 5371.8 5390.5 5392.4 5418.8 2913.5 2966.9 2976.2 2986.7 3006.7 5625.5 5716.8 5838.9 5852.9 5914.1 5718.3 5720.1 5723.4 5727.9 5728.9 5747.3 5761.3 5766.0 5770.7 5771.0 5371.0 5532.3 5585.2 5599.3 5606.3 5298.9 5409.6 5453.9 5531.6 5537.7 5734.8 5775.4 5792.4 5797.8 5804.7 4558.4 4607.8 4627.9 4737.0 4755.6 5586.6 5615.2 5615.5 5645.6 5648.7 5469.6 5470.8 5482.2 5502.9 5514.2 5299.5 5431.6 5449.9 5469.6 5528.3 5457.7 5457.8 5473.6 5484.3 5495.2 5444.2 5456.6 5456.7 5474.2 5497.5 5128.8 5339.7 5340.2 5351.4 5387.8 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - PROCESS | 29245 | [#5] yui.html Cycles:180 Average:17892.99 Median:22645.51 stddev:21002.18 (92.7%) stddev-sans-first:21021.99 07:13:16 INFO - PROCESS | 29245 | Values: 827.6 837.1 912.0 924.1 937.3 16581.5 18510.7 18573.8 18584.3 18724.6 15905.6 16138.3 16673.2 16900.8 16909.6 878.2 890.8 892.5 894.8 895.3 882.8 884.3 884.8 885.1 885.1 910.4 913.6 914.2 916.0 916.2 905.3 905.8 912.3 913.4 914.3 668.1 668.9 669.8 670.0 670.0 16431.1 16759.4 17227.8 17281.7 17317.4 16117.6 16350.4 16539.2 16638.2 16643.3 13450.0 13555.5 13658.0 13765.4 13798.5 3979.7 3987.2 4011.9 4073.8 4128.3 46073.8 60313.4 77785.2 78812.0 80009.2 12608.8 12922.4 12968.5 12987.8 12997.4 22952.4 23016.7 23044.0 23082.9 23324.4 9195.1 9285.2 9345.7 9401.5 9420.7 4983.8 5044.7 5059.5 5079.2 5176.0 3681.7 3743.7 3763.5 3778.8 3813.6 638.9 640.4 647.6 647.6 650.0 846.7 848.3 868.4 873.1 885.9 11648.6 11735.6 11927.2 12340.6 12383.9 659.7 661.9 675.9 723.3 869.1 5299.9 5485.7 5580.9 5618.9 5653.3 74040.3 74769.8 75976.6 76098.0 77345.6 66047.7 66272.0 66680.7 69680.3 69848.6 60380.0 61053.7 62744.1 63430.7 63903.4 11077.0 11169.4 11294.1 11384.4 11470.4 37606.6 39537.8 41217.2 42096.4 42989.0 49357.0 49722.0 50121.0 50971.7 52346.0 12630.5 12865.2 12867.5 13009.5 13233.1 15245.8 15335.7 15914.4 16033.2 16208.6 14816.3 15324.5 15353.9 17350.2 17504.4 16126.7 16261.3 17291.2 17338.7 17430.0 15087.2 15370.8 15517.5 15705.1 16026.8 11439.5 11461.2 11554.8 11691.6 11977.0 13253.9 13630.3 13764.3 13859.4 14146.4 07:13:16 INFO - PROCESS | 29245 | -------- Summary: end -------- 07:13:16 INFO - PROCESS | 29245 | 07:13:16 INFO - TEST-INFO | 29245: exit 0 07:13:16 INFO - TEST-OK | dromaeo_css | took 1114952ms 07:13:16 INFO - TEST-START | kraken 07:13:16 INFO - operating with platform_type : linux_ 07:13:16 INFO - Initialising browser for kraken test... 07:13:16 INFO - TEST-INFO | started process 29568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnLVn2R/profile http://localhost:38094/getInfo.html) 07:13:20 INFO - PROCESS | 29568 | __metrics Screen width/height:1600/1200 07:13:20 INFO - PROCESS | 29568 | colorDepth:24 07:13:20 INFO - PROCESS | 29568 | Browser inner width/height: 1024/697 07:13:20 INFO - PROCESS | 29568 | __metrics 07:13:21 INFO - PROCESS | 29568 | 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" 07:13:21 INFO - PROCESS | 29568 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:22 INFO - TEST-INFO | 29568: exit 0 07:13:22 INFO - Browser initialized. 07:13:22 INFO - Running cycle 1/1 for kraken test... 07:13:22 INFO - TEST-INFO | started process 29658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnLVn2R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:34 INFO - PROCESS | 29658 | RSS: Main: 140075008 07:13:34 INFO - PROCESS | 29658 | 07:13:36 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38094/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:37 INFO - PROCESS | 29658 | RSS: Main: 183091200 07:13:37 INFO - PROCESS | 29658 | 07:13:40 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38094/tests/kraken/driver.html?testName=audio-dft) 07:13:40 INFO - PROCESS | 29658 | RSS: Main: 173731840 07:13:40 INFO - PROCESS | 29658 | 07:13:43 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38094/tests/kraken/driver.html?testName=audio-fft) 07:13:44 INFO - PROCESS | 29658 | RSS: Main: 265138176 07:13:44 INFO - PROCESS | 29658 | 07:13:46 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38094/tests/kraken/driver.html?testName=audio-oscillator) 07:13:46 INFO - PROCESS | 29658 | RSS: Main: 171778048 07:13:46 INFO - PROCESS | 29658 | 07:13:49 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38094/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:13:49 INFO - PROCESS | 29658 | RSS: Main: 174370816 07:13:49 INFO - PROCESS | 29658 | 07:13:52 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38094/tests/kraken/driver.html?testName=imaging-darkroom) 07:13:53 INFO - PROCESS | 29658 | RSS: Main: 213135360 07:13:53 INFO - PROCESS | 29658 | 07:13:56 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38094/tests/kraken/driver.html?testName=imaging-desaturate) 07:13:57 INFO - PROCESS | 29658 | RSS: Main: 212570112 07:13:57 INFO - PROCESS | 29658 | 07:13:59 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38094/tests/kraken/driver.html?testName=json-parse-financial) 07:14:00 INFO - PROCESS | 29658 | RSS: Main: 210563072 07:14:00 INFO - PROCESS | 29658 | 07:14:02 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38094/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:02 INFO - PROCESS | 29658 | RSS: Main: 172625920 07:14:02 INFO - PROCESS | 29658 | 07:14:04 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:04 INFO - PROCESS | 29658 | RSS: Main: 179093504 07:14:04 INFO - PROCESS | 29658 | 07:14:06 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:07 INFO - PROCESS | 29658 | RSS: Main: 188653568 07:14:07 INFO - PROCESS | 29658 | 07:14:10 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:10 INFO - PROCESS | 29658 | RSS: Main: 197754880 07:14:10 INFO - PROCESS | 29658 | 07:14:13 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:14 INFO - PROCESS | 29658 | RSS: Main: 194158592 07:14:14 INFO - PROCESS | 29658 | 07:14:15 INFO - PROCESS | 29658 | Cycle 1(1): loaded http://localhost:38094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38094/tests/kraken/driver.html?testName=ai-astar) 07:14:16 INFO - PROCESS | 29658 | RSS: Main: 246620160 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | __start_tp_report 07:14:16 INFO - PROCESS | 29658 | _x_x_mozilla_page_load 07:14:16 INFO - PROCESS | 29658 | _x_x_mozilla_page_load_details 07:14:16 INFO - PROCESS | 29658 | |i|pagename|runs| 07:14:16 INFO - PROCESS | 29658 | |0;ai-astar;104;112;112;112;113;113;115;113;112;114 07:14:16 INFO - PROCESS | 29658 | |1;audio-beat-detection;148;117;116;148;116;116;115;117;131;122 07:14:16 INFO - PROCESS | 29658 | |2;audio-dft;169;161;162;164;161;161;161;162;161;161 07:14:16 INFO - PROCESS | 29658 | |3;audio-fft;76;75;75;108;77;76;77;77;93;75 07:14:16 INFO - PROCESS | 29658 | |4;audio-oscillator;82;83;100;82;83;82;99;84;83;106 07:14:16 INFO - PROCESS | 29658 | |5;imaging-gaussian-blur;113;113;113;113;114;113;114;112;113;113 07:14:16 INFO - PROCESS | 29658 | |6;imaging-darkroom;146;146;146;146;147;147;146;147;146;146 07:14:16 INFO - PROCESS | 29658 | |7;imaging-desaturate;93;94;94;94;93;94;94;94;94;95 07:14:16 INFO - PROCESS | 29658 | |8;json-parse-financial;56;55;54;53;54;54;55;55;55;55 07:14:16 INFO - PROCESS | 29658 | |9;json-stringify-tinderbox;54;55;54;53;53;54;55;54;54;53 07:14:16 INFO - PROCESS | 29658 | |10;stanford-crypto-aes;78;77;77;76;81;76;77;80;77;81 07:14:16 INFO - PROCESS | 29658 | |11;stanford-crypto-ccm;122;120;121;119;121;120;121;119;158;122 07:14:16 INFO - PROCESS | 29658 | |12;stanford-crypto-pbkdf2;167;159;170;162;162;161;162;159;158;157 07:14:16 INFO - PROCESS | 29658 | |13;stanford-crypto-sha256-iterative;62;61;59;59;59;59;62;60;59;59 07:14:16 INFO - PROCESS | 29658 | __end_tp_report 07:14:16 INFO - PROCESS | 29658 | __start_cc_report 07:14:16 INFO - PROCESS | 29658 | _x_x_mozilla_cycle_collect,1667 07:14:16 INFO - PROCESS | 29658 | __end_cc_report 07:14:16 INFO - PROCESS | 29658 | __startTimestamp1491833656011__endTimestamp 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | ------- Summary: start ------- 07:14:16 INFO - PROCESS | 29658 | Number of tests: 14 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 07:14:16 INFO - PROCESS | 29658 | Values: 104.0 112.0 112.0 112.0 113.0 113.0 115.0 113.0 112.0 114.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:119.50 stddev:13.22 (11.1%) stddev-sans-first:10.98 07:14:16 INFO - PROCESS | 29658 | Values: 148.0 117.0 116.0 148.0 116.0 116.0 115.0 117.0 131.0 122.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#2] audio-dft Cycles:10 Average:162.30 Median:161.50 stddev:2.54 (1.6%) stddev-sans-first:1.01 07:14:16 INFO - PROCESS | 29658 | Values: 169.0 161.0 162.0 164.0 161.0 161.0 161.0 162.0 161.0 161.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.50 stddev:10.95 (14.3%) stddev-sans-first:11.47 07:14:16 INFO - PROCESS | 29658 | Values: 76.0 75.0 75.0 108.0 77.0 76.0 77.0 77.0 93.0 75.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:83.00 stddev:9.35 (11.3%) stddev-sans-first:9.62 07:14:16 INFO - PROCESS | 29658 | Values: 82.0 83.0 100.0 82.0 83.0 82.0 99.0 84.0 83.0 106.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:14:16 INFO - PROCESS | 29658 | Values: 113.0 113.0 113.0 113.0 114.0 113.0 114.0 112.0 113.0 113.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:14:16 INFO - PROCESS | 29658 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 07:14:16 INFO - PROCESS | 29658 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 95.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.84 (1.5%) stddev-sans-first:0.73 07:14:16 INFO - PROCESS | 29658 | Values: 56.0 55.0 54.0 53.0 54.0 54.0 55.0 55.0 55.0 55.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 07:14:16 INFO - PROCESS | 29658 | Values: 54.0 55.0 54.0 53.0 53.0 54.0 55.0 54.0 54.0 53.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.50 stddev:1.94 (2.5%) stddev-sans-first:2.06 07:14:16 INFO - PROCESS | 29658 | Values: 78.0 77.0 77.0 76.0 81.0 76.0 77.0 80.0 77.0 81.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:121.00 stddev:11.89 (9.8%) stddev-sans-first:12.58 07:14:16 INFO - PROCESS | 29658 | Values: 122.0 120.0 121.0 119.0 121.0 120.0 121.0 119.0 158.0 122.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:4.06 (2.5%) stddev-sans-first:3.82 07:14:16 INFO - PROCESS | 29658 | Values: 167.0 159.0 170.0 162.0 162.0 161.0 162.0 159.0 158.0 157.0 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - PROCESS | 29658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:59.50 stddev:1.29 (2.2%) stddev-sans-first:1.12 07:14:16 INFO - PROCESS | 29658 | Values: 62.0 61.0 59.0 59.0 59.0 59.0 62.0 60.0 59.0 59.0 07:14:16 INFO - PROCESS | 29658 | -------- Summary: end -------- 07:14:16 INFO - PROCESS | 29658 | 07:14:16 INFO - TEST-INFO | 29658: exit 0 07:14:17 INFO - TEST-OK | kraken | took 60069ms 07:14:17 INFO - SUITE-END | took 1175s 07:14:17 INFO - Completed test suite (00:19:35) 07:14:17 INFO - javascript benchmark 07:14:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7866.919080794546, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3369.5451114099596, 3375.088726043967, 3400.778949368291, 3427.982860085699, 3448.7930724156536, 5751.539876809856, 5831.416858314172, 5837.7373018214175, 5844.035734103873, 5858.648481091127, 5882.441168089035, 5887.4406931341455, 5935.376785437532, 5941.762329506825, 5962.493188079007, 5360.731963401824, 5365.812196573121, 5393.568514518829, 5409.080456322415, 5481.890362192754, 5147.7426128693605, 5168.043911876296, 5448.210009548613, 5457.045017122007, 5457.590680698963, 5240.475952404748, 5321.281626980347, 5332.173513105475, 5408.594355423339, 5437.510624043835, 5417.864553386177, 5440.401555828856, 5447.754851031674, 5447.809326673587, 5449.291592093042, 5342.572594192456, 5346.438623944468, 5358.303420555342, 5393.568514518868, 5415.323084614423, 5592.356878958891, 5613.410591887834, 5730.19777231188, 5791.305043394777, 5791.594588378815, 6317.905231421532, 6317.905231421532, 6319.33646967071, 6319.6524191169465, 6320.399562041599, 6315.084312774622, 6347.238331400262, 6350.079238510436, 6352.936470635281, 6354.078658594524, 5554.166874968787, 5554.694491802949, 5796.507296879812, 5837.737301821428, 5907.14346419771, 6404.135441715402, 6437.259715132726, 6459.450946669585, 6464.0, 6464.547481676237, 6196.1015652731, 6203.937960620336, 6203.96898015507, 6206.131141640174, 6207.472364848948, 5879.794207202727, 5979.521638268928, 6147.231596050494, 6292.05619157121, 6299.149614802035, 6271.341509141565, 6275.6862156891975, 6275.6862156891975, 6282.277538083087, 6283.654399008007, 6000.429959153874, 6010.639361638316, 6037.72830222641, 6287.59130656515, 6290.968545157245, 4643.048175124091, 4676.321933319649, 4691.437027556715, 4691.62467002639, 4704.95295047052, 4120.8145633445965, 4122.319817230124, 4222.0, 4232.111256636079, 4266.424032755538, 5869.853253668693, 5883.470487656132, 5989.55078369124, 5993.430624090704, 5994.730237139339, 6188.257409110845, 6243.375662433811, 6247.96876015617, 6248.375162483715, 6251.59364641306, 5957.285125784847, 5961.850953726105, 5966.134910437962, 5981.850453738604, 5988.520918326523, 5127.025865085622, 5165.225216217597, 5267.209918512254, 5298.205269209572, 5332.093544097513, 6568.540202185896, 6572.638504882278, 6577.4409175218725, 6583.177102862142, 6586.73653053882, 6270.905936411049, 6375.0, 6376.139221205078, 6383.585066970632, 6397.6481293529305, 6150.907736384047, 6209.410106039919, 6422.518311126591, 6562.868742625216, 6579.2104947406615, 6240.500759939285, 6271.059341098871, 6277.183966084563, 6277.811665650038, 6282.308946016026, 6367.490600751836, 6380.266269379081, 6385.010323399881, 6385.425311721781, 6389.9361006389345, 5862.706864656665, 5896.528277737685, 6143.56995010345, 6195.132681424514, 6215.223097112861, 6090.847728806815, 6091.086337049478, 6147.631142131487, 6209.316975132822, 6214.067889816563, 6174.907376389448, 6187.319394866651, 6192.442680158807, 6193.009118541012, 6199.473044791243, 5871.295444546682, 5884.941150588611, 6037.516998640011, 6195.566310358412, 6232.376762323732, 5894.587378883437, 5948.851278717893, 5973.761049557969, 5990.7903223386975, 5992.700364981821], "value": 5770.637166213018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.394868310619, 791.6912404162376, 808.0626473290981, 877.749841295231, 894.4588523943011, 29641.703582964165, 41561.58438415615, 42376.57623423765, 42422.57577424225, 42652.0, 44835.551644483545, 44921.0, 45050.0, 45114.77442612791, 45151.83937124402, 7457.664405101784, 7642.847143057135, 9070.319726020558, 9194.908050919506, 9205.171534561889, 10396.896031039707, 10606.257561970666, 11042.723931901686, 11043.061339786127, 11058.502367393447, 10762.246642735012, 10809.567617295337, 10813.0, 10821.0, 10835.0, 10673.519691613896, 10724.463776811168, 10728.195385346053, 10728.678139655824, 10746.086582640406, 10381.42902140382, 10407.115395191418, 10426.113780328606, 10434.686959391154, 10435.843462348072, 41751.0, 41753.0, 41889.0, 41937.37093943563, 42136.78931605353, 4115.9588404115875, 4179.791010449465, 4182.121754431573, 4254.74471531706, 4313.266744653385, 29645.100189412864, 30228.395432091456, 30237.69762302371, 30635.234119146975, 31539.0, 4311.267084595626, 4332.956670433318, 4349.304111342201, 4352.978235108836, 4436.55634436557, 228738.0, 229551.99999999834, 230001.0, 230124.0, 230344.0, 51303.486965130614, 51513.484865150866, 51519.22721159185, 51565.742171288905, 51660.22509662358, 54188.72905635447, 54244.0, 54265.1860222097, 54279.72860135674, 54337.18494222511, 16200.75698864518, 16386.26261818221, 16394.426195083353, 16411.0, 16511.83488165103, 13036.608901732963, 13394.129381590361, 14471.276436178148, 14624.634384140269, 14637.560873173821, 13080.803787943189, 13159.736805263841, 13187.736245275233, 13194.076414650883, 13318.0, 5564.27664403633, 5579.13523403873, 5624.803131890364, 5702.201691763156, 5755.165501002331, 1017.6082208349839, 1019.6278358399279, 1030.0832259289239, 1031.2214278219897, 1036.828923227659, 27341.90632374683, 28723.0, 28813.711862881522, 29089.0, 29191.0, 1256.1772039314264, 1267.0876968582606, 1269.8412698412699, 1291.3672300572653, 1307.6403988903128, 13260.138091024246, 13570.117942333914, 13611.319434028457, 13682.52111176124, 13857.514986975408, 330914.0, 331714.0, 332960.0, 333582.0, 336004.0, 45340.0, 45816.312755308696, 45890.311645325346, 45984.3102353465, 45996.770016150374, 1488.3153749275455, 1515.2272341106116, 1515.3786947351532, 1538.538438468455, 1541.6608346163825, 23998.2483030431, 24870.63211523311, 25345.87327063353, 25419.36451588651, 25444.491110178064, 36157.638423615426, 36181.457278140326, 36255.81872090622, 36280.63719362878, 36289.818550907075, 295863.0, 296831.0, 296923.0, 297154.0, 298561.0, 24231.273061808173, 24756.876215618806, 27176.320591985357, 27843.721562784922, 28713.0, 36871.0, 36918.26163476662, 36970.0, 37220.81389593035, 37486.0, 28679.42641147207, 28737.85631071831, 29002.564961526015, 29063.709362906946, 29469.852650737466, 28763.137105886857, 29228.26929326784, 29261.268468288465, 29394.412111758073, 29742.10773676793, 32793.18017049593, 32835.34329313448, 33059.504107437926, 35238.647613523535, 36132.09669758277, 28583.571246430904, 28806.42387152287, 29420.852895735385, 29474.263143421587, 29710.554341685325, 24269.514609707352, 24413.877930610233, 24619.38451538654, 24771.0, 27222.863885680446], "value": 18296.9545572075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.09355242738303, 465.19521228275084, 466.0701899710079, 479.5204795204795, 490.1765034741634, 19635.60728785425, 21229.150833966643, 21665.891670541645, 21678.0, 21993.450163745914, 22335.888320558413, 22536.0, 22879.0, 22922.885385573092, 23075.76924230757, 6610.338966103399, 6627.569208001489, 6809.387155156035, 6865.450763938873, 6915.861682766342, 6795.252522222576, 6908.516403851732, 6908.827279318032, 6909.585424874524, 7173.354398104169, 7615.5811430371305, 7649.08211014679, 7655.617219139049, 7665.156832748393, 7669.156392796788, 7183.604901730403, 7441.0, 7465.514741541782, 7492.400607951406, 7663.885041724378, 7158.677859496283, 7328.9267107329315, 7378.889316660255, 7422.072240969879, 7435.033445652085, 24830.0, 25174.622380664303, 25210.747892521205, 25304.367390815194, 25381.238562843144, 3065.432894914448, 3074.707902749235, 3199.2481766784786, 3202.9359412811614, 3379.1721028347965, 15454.304556294881, 16111.194440277939, 16207.432739854166, 16552.917235413865, 16585.83414165855, 2244.0350649220827, 2256.3569382725846, 2304.43541332373, 2344.179537161997, 2348.495073559176, 117978.4101079489, 121761.0, 121822.0, 122189.77810221873, 123278.0, 17465.650686986188, 18249.543761405806, 18552.0, 18571.907140464213, 18855.434336969913, 31182.844085779427, 31486.212844679067, 31556.211094722355, 31679.0, 31787.523187152212, 10539.003130833615, 10628.787424251626, 10653.147748180127, 10872.130229581615, 10943.781124377627, 9056.683016094537, 9058.637654493747, 9107.08929107084, 9112.179903808688, 9284.442933424016, 9101.317401194805, 9365.0, 9481.905180948102, 9496.715098547054, 9614.615415383447, 3804.885853424402, 3832.405977073558, 3869.613038696164, 3973.2252210819192, 4048.919021619551, 940.4592359393239, 941.7457286532734, 949.2880339745191, 951.4053716427233, 960.851068084448, 20224.0, 21530.354089377342, 21725.91370431472, 21811.34565962992, 22065.0, 953.270747877874, 955.2835373469898, 958.4249450329886, 967.6468089147411, 971.844504879216, 11327.433628318551, 11651.242669226473, 11879.22785018971, 11887.524499020115, 11909.166358354832, 462855.0, 465911.0, 653870.0, 700766.0, 704600.0, 107663.0, 124346.0, 124600.0, 126704.0, 127719.0, 1306.6014865465934, 1327.3164320375015, 1390.4368730663896, 1390.9443622254996, 1394.4352537222442, 19117.71323430122, 19182.808171918103, 19553.70669439988, 19554.21783128716, 19559.0, 51083.0, 51361.7431912853, 52118.0, 52942.73528632486, 53085.0, 67773.0, 68592.6570367145, 69250.65374673094, 70153.0, 70429.0, 10886.212546468949, 11221.0, 11524.942375288405, 11629.069674425857, 12145.271283723005, 13987.300634968007, 14022.509212177525, 14373.425062997363, 14702.55892323232, 14765.261736913326, 12654.87345126537, 12861.614151575468, 12887.80668289995, 12943.09398342107, 12958.28729419891, 11003.394813285346, 11064.391458469861, 11177.964038535316, 11189.608363707232, 11266.098712102848, 12504.937475312565, 13051.21692698441, 13155.60533184006, 13170.670733231362, 13541.59375218745, 12478.18891772032, 12567.497300107892, 12594.559190428292, 12604.24374537494, 12611.684707882376, 11843.650226590406, 12538.498460061495, 12695.55565555201, 13007.284599347127, 13350.666233344244], "value": 11679.022913942665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.0422606288632, 1522.4214798376615, 1522.7868098466215, 1527.969440611187, 1538.523057852066, 9265.90734092659, 11238.0, 11605.941970290147, 11990.40047997601, 12031.639050828468, 11671.766564668702, 11750.647480575597, 11793.056555475563, 11794.528218871257, 11795.174337796358, 2071.2025870040065, 2128.5849259394427, 2436.6466862304956, 2457.8402403843784, 2497.1509686706518, 2464.5687004774095, 2495.7629025242572, 2507.5486412445753, 2510.1089113364765, 2510.585753350704, 2279.3389916924157, 2290.518991011881, 2291.140822191678, 2296.701428814252, 2304.654301854727, 2348.9060437582475, 2360.103160798894, 2368.8697121658215, 2368.928932132039, 2452.4849781545895, 2448.9142879999295, 2473.5423946569763, 2473.849659908133, 2475.5420247254315, 2479.8636075015866, 11868.228565143325, 11962.222455540363, 11968.521259149624, 11976.580819671357, 11992.940035299855, 6068.180795592582, 6118.235220597426, 6180.9381906180815, 6185.165002724664, 6187.0, 3439.501272315525, 3470.548828652284, 3543.539339885824, 3692.2615476904457, 3696.9260614787822, 1372.7940808878648, 1418.4751641892462, 1479.1864474539068, 2297.1615360393503, 2364.9172278970154, 17750.733738993924, 17855.464336069937, 17868.0, 17882.731759023623, 17897.46307610774, 5082.237664350377, 5098.745062746922, 5148.2020286855595, 5260.789568417297, 5312.628116031918, 12918.547850825364, 13432.19406835593, 13453.529126480526, 13456.327183640975, 13473.595792126252, 6215.9378406216265, 6226.377362263737, 6239.157713708682, 6240.500759939194, 6245.18812554365, 5635.436456354331, 5640.379558248589, 5644.294463192101, 5689.402612725604, 5698.430156984268, 4002.0, 4145.689073319513, 4195.370694395804, 4237.110206856594, 4258.190943720683, 1102.1513434655271, 1103.779244151173, 1111.9110471162287, 1127.7180704823795, 1133.0425790207262, 866.4151697604092, 870.8780770692108, 890.9465432074096, 930.283681565191, 1093.753905371301, 7457.515261507984, 7569.0, 7584.772456826304, 7603.0876294843865, 7825.060992680915, 1058.6241884131177, 1073.7798751255973, 1083.6369816111692, 1115.5816568786704, 1135.3755434510986, 4695.7886895089805, 4818.277258411266, 4831.202851529459, 4976.576990955809, 5016.097102521581, 14520.782188267185, 14873.925630371996, 14879.0, 14881.181535015678, 14891.957562970489, 14501.202433866029, 14613.415463381558, 14645.780313295309, 14714.852851471562, 14793.556193314218, 10792.568297268179, 10959.342439453658, 11031.779364412827, 11082.0, 11123.777524449466, 7381.929620205147, 7501.249875012455, 7631.275028872248, 7645.159032506531, 7648.311651951351, 13094.952403807481, 13175.802362964372, 13194.274314912773, 13236.801447978096, 13285.800712989507, 10616.203784716332, 12721.93639031799, 13451.415000989433, 13649.181049137083, 13770.24263665508, 9328.95335523318, 9441.197498212729, 9536.952315238379, 9546.85679714791, 9550.808983820423, 11083.61207357771, 11123.165762568002, 11128.221024528206, 11262.38056906878, 11297.378644174649, 9440.244780417688, 9444.802778466881, 9557.952210238904, 9670.081342272755, 9878.950605246928, 9229.907700923173, 9349.158575728217, 9412.717618471457, 9506.096920792514, 9646.951765241129, 8722.0, 8736.650533978824, 8843.955780221058, 8846.292296616384, 8852.468851868909, 6227.564070515021, 6285.465735412541, 6319.304876463677, 6347.333529979285, 6403.0715546246465, 6436.227652681709, 6474.420634054962, 6525.804225873231, 6543.443807276435, 6563.0811686364905], "value": 5540.943055141135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.62222755065335, 423.47700589771625, 426.98292068317267, 436.6332280884057, 440.47803353026666, 5128.256402821593, 5193.5325820676135, 5210.687358758477, 5277.736113194334, 5287.180487024508, 5079.212722028083, 5158.561522270602, 5200.947990520093, 5230.450802665722, 5260.0, 4352.912941741163, 4366.759828209447, 4379.9781001095025, 4404.427424434819, 4432.7118737282135, 4444.888877778065, 4456.17560751262, 4469.955300447003, 4475.865724028285, 4479.641628669715, 4237.389791879082, 4379.627731642814, 4427.645788336926, 4430.401895744066, 4443.866683999469, 4383.649308055348, 4386.276264416368, 4398.406215160944, 4400.515943246241, 4401.779911004453, 4150.232207041707, 4161.461508479825, 4171.290880550314, 4179.874603761861, 4192.496900371944, 4917.901641967141, 5053.444121146707, 5079.415867175285, 5127.512886275797, 5199.896002079975, 5044.369453818273, 5082.678503589056, 5084.339035925306, 5108.4125325587665, 5119.513646203604, 5466.480684334982, 5502.284702988626, 5507.421720719347, 5549.556035517149, 5551.1673249012565, 4366.5851744084575, 4544.455324846592, 4552.4764652065105, 4563.452385713736, 4597.563231493036, 5424.647397919122, 5553.305836770403, 5612.270404847343, 5651.9152212716845, 5700.914486282709, 4677.695949763254, 4677.8773094457765, 4705.905881882343, 4708.270218116198, 4715.882102947454, 4529.773511324421, 4623.722576645412, 4667.183242932541, 4772.880677983008, 4779.569838714532, 4954.860382112134, 4990.50094990498, 5022.949770502321, 5030.622703297267, 5043.722595257223, 5400.189971504227, 5459.945400545944, 5489.313835770528, 5490.533304669068, 5518.751656175482, 1564.319521008365, 1606.253092312057, 1625.4473479016954, 1630.6086539230498, 1649.3897258014372, 1246.4391024039037, 1253.921627400435, 1256.836611240551, 1275.2029981261712, 1276.8827276133384, 5255.211718242218, 5288.180332048539, 5326.975749215351, 5348.839534813962, 5361.356637203483, 5573.219749235111, 5602.243697100839, 5631.267935168402, 5651.519620832275, 5665.9716701417055, 5067.442581316052, 5371.811986580529, 5390.4879036491475, 5392.355331623892, 5418.756155972991, 2913.533834586456, 2966.9406611867644, 2976.1666733314705, 2986.7013298670395, 3006.669266380696, 5625.521830644359, 5716.771329146787, 5838.8540286492325, 5852.941470585325, 5914.112883067574, 5718.342390625048, 5720.141978703145, 5723.399043100415, 5727.856803579861, 5728.911506813692, 5747.339056008613, 5761.251037365199, 5765.971170144123, 5770.682612456355, 5771.0, 5370.9731451342495, 5532.30846144232, 5585.151572698034, 5599.348192283368, 5606.327240731139, 5298.8940221196135, 5409.594280428905, 5453.863653408538, 5531.640443371329, 5537.667739935617, 5734.799282025109, 5775.372205646505, 5792.420757924174, 5797.76808927655, 5804.6807425590305, 4558.427342566809, 4607.825004623799, 4627.93058104122, 4737.0, 4755.574656924924, 5586.581006424453, 5615.241942337895, 5615.522680572197, 5645.633033852787, 5648.6840395437675, 5469.589780766538, 5470.781168753205, 5482.23248745184, 5502.9174562380795, 5514.228008078792, 5299.463155684808, 5431.646942948696, 5449.945500544944, 5469.589780766538, 5528.281323427928, 5457.717436402521, 5457.808976685797, 5473.616846820684, 5484.287042684585, 5495.203195536705, 5444.183372494158, 5456.563474922076, 5456.66311753607, 5474.233607294902, 5497.532709719719, 5128.79484820603, 5339.733013349394, 5340.2256672783005, 5351.357837059578, 5387.838364849061], "value": 4409.479384663584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.5944488430112, 837.1335667584052, 911.9863202051969, 924.1313165624308, 937.3204426790576, 16581.502554923358, 18510.72233916489, 18573.814261857377, 18584.256629734813, 18724.625507489844, 15905.602359941007, 16138.273777680004, 16673.16634168293, 16900.83099169008, 16909.57726056846, 878.1964502480223, 890.8218356328761, 892.4689809563332, 894.8299823033602, 895.3106108296607, 882.7969566999594, 884.3102380143466, 884.849575572151, 885.0706757904208, 885.1325700813206, 910.4127837544779, 913.6025828764475, 914.2092090341839, 916.0335845682802, 916.1571354353977, 905.2848249882585, 905.8097799462088, 912.2565109435789, 913.4427998920653, 914.3234006834961, 668.1180841289499, 668.906353110565, 669.8459354348479, 670.0083875863701, 670.0251134599147, 16431.096289704063, 16759.413420530345, 17227.827721722748, 17281.740773888403, 17317.393891213873, 16117.645889055659, 16350.427735029218, 16539.173041347884, 16638.168091595373, 16643.33426662932, 13450.0, 13555.525556605471, 13658.0, 13765.38055787482, 13798.517051903236, 3979.6617287530594, 3987.2424239394422, 4011.8796436106963, 4073.8370465181356, 4128.298189307795, 46073.76963115163, 60313.39686603165, 77785.22214777893, 78812.0, 80009.19990800133, 12608.81086783699, 12922.353882305848, 12968.481260749464, 12987.805182922264, 12997.350132493337, 22952.4261893454, 23016.65475017876, 23044.0, 23082.8845855773, 23324.41688957756, 9195.080491950752, 9285.210757085724, 9345.672901448417, 9401.482918439415, 9420.717378478657, 4983.775730092155, 5044.672096313801, 5059.519345662156, 5079.2381142828135, 5176.016556854186, 3681.7238707097076, 3743.6630703236838, 3763.5483741951143, 3778.7543809652284, 3813.618638136164, 638.8945823939091, 640.4204195203348, 647.5596594315816, 647.5920170292685, 650.0249625561657, 846.7121178799238, 848.2577744473585, 868.3617541107282, 873.1486800369589, 885.8582626779685, 11648.592299269485, 11735.589254376056, 11927.1650984432, 12340.629781106582, 12383.938080309541, 659.7295109005285, 661.8808614449446, 675.8817206988757, 723.2731105239201, 869.1265278395173, 5299.894002119936, 5485.6982865942755, 5580.91628625571, 5618.943810561842, 5653.321601407857, 74040.25959740333, 74769.80473090884, 75976.62011689907, 76098.0, 77345.61327193328, 66047.66976165089, 66272.0, 66680.6665966667, 69680.3031969684, 69848.59179433143, 60380.0, 61053.694731526055, 62744.05883911654, 63430.68284658547, 63903.36096639067, 11077.0, 11169.385683787144, 11294.096472282363, 11384.37385943781, 11470.369129697612, 37606.62393376031, 39537.80231098826, 41217.1756564873, 42096.3685544711, 42989.0, 49357.0, 49722.0, 50121.0, 50971.74514127554, 52346.0, 12630.494780208688, 12865.163764355288, 12867.549635762703, 13009.479620815062, 13233.073684842353, 15245.771313430529, 15335.693286134438, 15914.363425463314, 16033.198340083183, 16208.594785129995, 14816.333265003317, 15324.463643772415, 15353.923230383776, 17350.219240134476, 17504.387346443324, 16126.67746645037, 16261.349546018027, 17291.221895015005, 17338.653226935643, 17430.0, 15087.245637717851, 15370.769438458208, 15517.45688900883, 15705.13621750769, 16026.759598605797, 11439.485223164811, 11461.197716160123, 11554.826677599674, 11691.590794322157, 11977.0, 13253.933730331286, 13630.318484075558, 13764.314042777054, 13859.445622175403, 14146.363413646617], "value": 7867.033344981333, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 112.0, 113.0, 113.0, 115.0, 113.0, 112.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 116.0, 148.0, 116.0, 116.0, 115.0, 117.0, 131.0, 122.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 161.0, 162.0, 164.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 108.0, 77.0, 76.0, 77.0, 77.0, 93.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 100.0, 82.0, 83.0, 82.0, 99.0, 84.0, 83.0, 106.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 53.0, 54.0, 55.0, 54.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 76.0, 81.0, 76.0, 77.0, 80.0, 77.0, 81.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 121.0, 119.0, 121.0, 120.0, 121.0, 119.0, 158.0, 122.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 159.0, 170.0, 162.0, 162.0, 161.0, 162.0, 159.0, 158.0, 157.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 59.0, 59.0, 59.0, 59.0, 62.0, 60.0, 59.0, 59.0], "value": 59.9, "unit": "score"}]}]} 07:14:17 INFO - Return code: 0 07:14:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:14:17 ERROR - # TBPL SUCCESS # 07:14:17 INFO - Running post-action listener: _resource_record_post_action 07:14:17 INFO - [mozharness: 2017-04-10 14:14:17.323036Z] Finished run-tests step (success) 07:14:17 INFO - Running post-run listener: _resource_record_post_run 07:14:17 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370786304; Read time: 8; Write time: 299960 07:14:17 INFO - TinderboxPrint: CPU usage
13.2% 07:14:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:14:17 INFO - TinderboxPrint: I/O write bytes / time
370,786,304 / 299,960 07:14:17 INFO - TinderboxPrint: CPU idle
8,260.0 (86.8%) 07:14:17 INFO - TinderboxPrint: CPU user
1,205.3 (12.7%) 07:14:17 INFO - TinderboxPrint: Swap in / out
0 / 0 07:14:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116555776; Read time: 0; Write time: 121728 07:14:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254017536; Read time: 8; Write time: 178212 07:14:17 INFO - Running post-run listener: _upload_blobber_files 07:14:17 INFO - Blob upload gear active. 07:14:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:14:17 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 07:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:14:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:14:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:14:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:19 INFO - (blobuploader) - INFO - Done attempting. 07:14:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:14:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:19 INFO - (blobuploader) - INFO - Done attempting. 07:14:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:14:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:14:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:22 INFO - (blobuploader) - INFO - Done attempting. 07:14:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:14:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:23 INFO - (blobuploader) - INFO - Done attempting. 07:14:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:14:23 INFO - Return code: 0 07:14:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:14:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:14:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/445fbae953666bc936cb42d8fa910ea6f74f6fb3931c209000ef7f2e146e02c2c32322d5218044e5106e3e365f867e2db0b7e824eaeb7471e7594f70b87262e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f0ee77ef455efab7485f06d056ef745068e9cf758ffcf2a77b21afa456dc95a97bd4d801c4d3926bf04d7abcae5dd2bdc495a0e4879f37912a8360d68c2c3bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d146140e88eb9dc3805606bc0ac834508daff7f0657898ba23450a872b0db4aeebacd1ff0e80b8d25f048faa591b8ca61e4c71c3cd2c0109aa0702759cabe268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d83d36c6cb8adcedad255aaa696619218386ddfa89ee5a45d0bba2806a320915477f7c096423e9dff8a30fcfa6ccb98c48a8426753e47f82a2319f457064b237"} 07:14:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:14:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:14:23 INFO - Contents: 07:14:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/445fbae953666bc936cb42d8fa910ea6f74f6fb3931c209000ef7f2e146e02c2c32322d5218044e5106e3e365f867e2db0b7e824eaeb7471e7594f70b87262e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f0ee77ef455efab7485f06d056ef745068e9cf758ffcf2a77b21afa456dc95a97bd4d801c4d3926bf04d7abcae5dd2bdc495a0e4879f37912a8360d68c2c3bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d146140e88eb9dc3805606bc0ac834508daff7f0657898ba23450a872b0db4aeebacd1ff0e80b8d25f048faa591b8ca61e4c71c3cd2c0109aa0702759cabe268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d83d36c6cb8adcedad255aaa696619218386ddfa89ee5a45d0bba2806a320915477f7c096423e9dff8a30fcfa6ccb98c48a8426753e47f82a2319f457064b237"} 07:14:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:14:23 INFO - Copying logs to upload dir... 07:14:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:14:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.872042 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-10 07:14:23.391079) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:14:23.394927) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/445fbae953666bc936cb42d8fa910ea6f74f6fb3931c209000ef7f2e146e02c2c32322d5218044e5106e3e365f867e2db0b7e824eaeb7471e7594f70b87262e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f0ee77ef455efab7485f06d056ef745068e9cf758ffcf2a77b21afa456dc95a97bd4d801c4d3926bf04d7abcae5dd2bdc495a0e4879f37912a8360d68c2c3bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d146140e88eb9dc3805606bc0ac834508daff7f0657898ba23450a872b0db4aeebacd1ff0e80b8d25f048faa591b8ca61e4c71c3cd2c0109aa0702759cabe268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d83d36c6cb8adcedad255aaa696619218386ddfa89ee5a45d0bba2806a320915477f7c096423e9dff8a30fcfa6ccb98c48a8426753e47f82a2319f457064b237"} build_url:https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/UvA_yJL2SZOnrEo4tVr9IA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/445fbae953666bc936cb42d8fa910ea6f74f6fb3931c209000ef7f2e146e02c2c32322d5218044e5106e3e365f867e2db0b7e824eaeb7471e7594f70b87262e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f0ee77ef455efab7485f06d056ef745068e9cf758ffcf2a77b21afa456dc95a97bd4d801c4d3926bf04d7abcae5dd2bdc495a0e4879f37912a8360d68c2c3bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d146140e88eb9dc3805606bc0ac834508daff7f0657898ba23450a872b0db4aeebacd1ff0e80b8d25f048faa591b8ca61e4c71c3cd2c0109aa0702759cabe268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d83d36c6cb8adcedad255aaa696619218386ddfa89ee5a45d0bba2806a320915477f7c096423e9dff8a30fcfa6ccb98c48a8426753e47f82a2319f457064b237"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:14:23.420441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:14:23.420812) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491832411.872716-118389834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:14:23.503377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:14:23.503694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:14:23.503977) ========= ========= Total master_lag: 0.16 =========