builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1483647716.13 results: success (0) revision: a208bb74042cdb0a434d4c85f9b7640126be863c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.132627) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.134133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.134842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.183687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.184329) ========= 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=00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 12:21:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.3M=0s 2017-01-05 12:21:56 (25.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.297623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.298535) ========= 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=00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014941 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:56.349985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 12:21:56.350345) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev a208bb74042cdb0a434d4c85f9b7640126be863c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev a208bb74042cdb0a434d4c85f9b7640126be863c --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=00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 12:21:56,578 truncating revision to first 12 chars 2017-01-05 12:21:56,578 Setting DEBUG logging. 2017-01-05 12:21:56,579 attempt 1/10 2017-01-05 12:21:56,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/a208bb74042c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 12:21:57,875 unpacking tar archive at: graphics-a208bb74042c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.607781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 12:21:57.971930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:57.972310) ========= script_repo_revision: a208bb74042cdb0a434d4c85f9b7640126be863c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:57.972746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:57.973051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 12:21:57.982285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-05 12:21:57.982632) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:21:58 INFO - MultiFileLogger online at 20170105 12:21:58 in /builds/slave/test 12:21:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 12:21:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:21:58 INFO - {'append_to_log': False, 12:21:58 INFO - 'base_work_dir': '/builds/slave/test', 12:21:58 INFO - 'blob_upload_branch': 'Graphics', 12:21:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:21:58 INFO - 'branch': 'Graphics', 12:21:58 INFO - 'buildbot_json_path': 'buildprops.json', 12:21:58 INFO - 'config_files': ('talos/linux_config.py',), 12:21:58 INFO - 'default_actions': ('clobber', 12:21:58 INFO - 'read-buildbot-config', 12:21:58 INFO - 'download-and-extract', 12:21:58 INFO - 'populate-webroot', 12:21:58 INFO - 'create-virtualenv', 12:21:58 INFO - 'install', 12:21:58 INFO - 'run-tests'), 12:21:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:21:58 INFO - 'download_minidump_stackwalk': True, 12:21:58 INFO - 'download_symbols': 'ondemand', 12:21:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:21:58 INFO - 'tooltool.py': '/tools/tooltool.py', 12:21:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:21:58 INFO - '/tools/misc-python/virtualenv.py')}, 12:21:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:21:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:21:58 INFO - 'installer_path': 'installer.exe', 12:21:58 INFO - 'log_level': 'info', 12:21:58 INFO - 'log_name': 'talos', 12:21:58 INFO - 'log_to_console': True, 12:21:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:21:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:21:58 INFO - 'opt_config_files': (), 12:21:58 INFO - 'pip_index': False, 12:21:58 INFO - 'sps_profile': False, 12:21:58 INFO - 'sps_profile_interval': 0, 12:21:58 INFO - 'suite': 'dromaeojs-e10s', 12:21:58 INFO - 'system_bits': '32', 12:21:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:21:58 INFO - 'title': 'talos-linux64-ix-016', 12:21:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:21:58 INFO - 'use_talos_json': True, 12:21:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:21:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:21:58 INFO - 'work_dir': 'build'} 12:21:58 INFO - [mozharness: 2017-01-05 20:21:58.312240Z] Running clobber step. 12:21:58 INFO - Running pre-action listener: _resource_record_pre_action 12:21:58 INFO - Running main action method: clobber 12:21:58 INFO - rmtree: /builds/slave/test/build 12:21:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:21:58 INFO - Running post-action listener: _resource_record_post_action 12:21:58 INFO - [mozharness: 2017-01-05 20:21:58.770867Z] Finished clobber step (success) 12:21:58 INFO - [mozharness: 2017-01-05 20:21:58.770968Z] Running read-buildbot-config step. 12:21:58 INFO - Running pre-action listener: _resource_record_pre_action 12:21:58 INFO - Running main action method: read_buildbot_config 12:21:58 INFO - Using buildbot properties: 12:21:58 INFO - { 12:21:58 INFO - "project": "", 12:21:58 INFO - "product": "firefox", 12:21:58 INFO - "who": "jmuizelaar@mozilla.com", 12:21:58 INFO - "installer_path": "public/build/target.tar.bz2", 12:21:58 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 12:21:58 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 12:21:58 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 12:21:58 INFO - "stage_platform": "linux64", 12:21:58 INFO - "basedir": "/builds/slave/test", 12:21:58 INFO - "buildnumber": 45, 12:21:58 INFO - "platform": "ubuntu64_hw", 12:21:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:21:58 INFO - "slavebuilddir": "test", 12:21:58 INFO - "taskId": "Ce6Ut_3VTeGljZZVN02X_A", 12:21:58 INFO - "branch": "graphics", 12:21:58 INFO - "script_repo_revision": "default", 12:21:58 INFO - "revision": "a208bb74042cdb0a434d4c85f9b7640126be863c", 12:21:58 INFO - "slavename": "talos-linux64-ix-016", 12:21:58 INFO - "repo_path": "projects/graphics" 12:21:58 INFO - } 12:21:58 INFO - Finding installer, test and symbols from parent task. 12:21:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ce6Ut_3VTeGljZZVN02X_A'}, attempt #1 12:21:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ce6Ut_3VTeGljZZVN02X_A'}, attempt #1 12:21:59 INFO - Task dependencies: fNXp-SB-RRykgRt2hGbRIA 12:21:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA'}, attempt #1 12:22:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2 12:22:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/test_packages.json 12:22:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.crashreporter-symbols.zip 12:22:00 INFO - Running post-action listener: _resource_record_post_action 12:22:00 INFO - [mozharness: 2017-01-05 20:22:00.184909Z] Finished read-buildbot-config step (success) 12:22:00 INFO - [mozharness: 2017-01-05 20:22:00.185126Z] Running download-and-extract step. 12:22:00 INFO - Running pre-action listener: _resource_record_pre_action 12:22:00 INFO - Running main action method: download_and_extract 12:22:00 INFO - mkdir: /builds/slave/test/build/tests 12:22: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')]} 12:22:00 INFO - trying https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.test_packages.json 12:22:00 INFO - Downloading https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:22:00 INFO - Downloaded 896 bytes. 12:22:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:22:00 INFO - Using the following test package requirements: 12:22:00 INFO - {u'common': [u'target.common.tests.zip'], 12:22:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:22:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:22:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:22:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:22:00 INFO - u'mozbase': [u'target.common.tests.zip'], 12:22:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:22:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:22:00 INFO - u'web-platform': [u'target.common.tests.zip', 12:22:00 INFO - u'target.web-platform.tests.zip'], 12:22:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:22:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:22:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.common.tests.zip 12:22:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:22:00 INFO - Fetch https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.common.tests.zip into memory 12:22:01 INFO - Expected file size: 20244966 12:22:01 INFO - Obtained file size: 20244966 12:22:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:22:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.common.tests.zip 12:22:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:22:05 INFO - Fetch https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.common.tests.zip into memory 12:22:06 INFO - Expected file size: 20244966 12:22:06 INFO - Obtained file size: 20244966 12:22:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.talos.tests.zip 12:22:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:22:10 INFO - Fetch https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.talos.tests.zip into memory 12:22:11 INFO - Expected file size: 14403730 12:22:11 INFO - Obtained file size: 14403730 12:22:11 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')]} 12:22:11 INFO - trying https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2 12:22:11 INFO - Downloading https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:22:12 INFO - Downloaded 55871587 bytes. 12:22:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2 12:22:12 INFO - mkdir: /builds/slave/test/properties 12:22:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:22:12 INFO - Writing to file /builds/slave/test/properties/build_url 12:22:12 INFO - Contents: 12:22:12 INFO - build_url:https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2 12:22:12 INFO - Running post-action listener: _resource_record_post_action 12:22:12 INFO - Running post-action listener: set_extra_try_arguments 12:22:12 INFO - [mozharness: 2017-01-05 20:22:12.856825Z] Finished download-and-extract step (success) 12:22:12 INFO - [mozharness: 2017-01-05 20:22:12.856922Z] Running populate-webroot step. 12:22:12 INFO - Running pre-action listener: _resource_record_pre_action 12:22:12 INFO - Running main action method: populate_webroot 12:22:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:22:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:22:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:22:12 INFO - '--tppagecycles', 12:22:12 INFO - '7'], 12:22:12 INFO - 'tests': ['tsvgm']}}, 12:22:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:22:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:22:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:22:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:22:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:22:12 INFO - 'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:22:12 INFO - 'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['damp', 'tps']}, 12:22:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:22:12 INFO - 'tests': ['damp', 'tps']}, 12:22:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['dromaeo_dom']}, 12:22:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:22:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['basic_compositor_video']}, 12:22:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:22:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['a11yr', 12:22:12 INFO - 'ts_paint', 12:22:12 INFO - 'tpaint', 12:22:12 INFO - 'sessionrestore', 12:22:12 INFO - 'sessionrestore_no_auto_restore', 12:22:12 INFO - 'tabpaint']}, 12:22:12 INFO - 'other-e10s': {'tests': ['a11yr', 12:22:12 INFO - 'ts_paint', 12:22:12 INFO - 'tpaint', 12:22:12 INFO - 'sessionrestore', 12:22:12 INFO - 'sessionrestore_no_auto_restore', 12:22:12 INFO - 'tabpaint']}, 12:22:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:22:12 INFO - 'ts_paint', 12:22:12 INFO - 'tpaint', 12:22:12 INFO - 'sessionrestore', 12:22:12 INFO - 'sessionrestore_no_auto_restore', 12:22:12 INFO - 'tabpaint']}, 12:22:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:22:12 INFO - 'ts_paint', 12:22:12 INFO - 'tpaint', 12:22:12 INFO - 'sessionrestore', 12:22:12 INFO - 'sessionrestore_no_auto_restore', 12:22:12 INFO - 'tabpaint']}, 12:22:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['a11yr', 12:22:12 INFO - 'ts_paint', 12:22:12 INFO - 'tpaint', 12:22:12 INFO - 'sessionrestore', 12:22:12 INFO - 'sessionrestore_no_auto_restore', 12:22:12 INFO - 'tabpaint']}, 12:22:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['a11yr', 12:22:12 INFO - 'ts_paint', 12:22:12 INFO - 'tpaint', 12:22:12 INFO - 'sessionrestore', 12:22:12 INFO - 'sessionrestore_no_auto_restore', 12:22:12 INFO - 'tabpaint']}, 12:22:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['tsvgx', 12:22:12 INFO - 'tsvgr_opacity', 12:22:12 INFO - 'tart', 12:22:12 INFO - 'tscrollx', 12:22:12 INFO - 'cart', 12:22:12 INFO - 'tsvg_static']}, 12:22:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:22:12 INFO - 'tsvgr_opacity', 12:22:12 INFO - 'tart', 12:22:12 INFO - 'tscrollx', 12:22:12 INFO - 'cart', 12:22:12 INFO - 'tsvg_static']}, 12:22:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:22:12 INFO - 'talos_options': ['--disable-e10s'], 12:22:12 INFO - 'tests': ['tp5o']}, 12:22:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:22:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:22:12 INFO - 'talos_options': ['--disable-e10s', 12:22:12 INFO - '--xperf_path', 12:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:12 INFO - 'tests': ['tp5n']}, 12:22:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:22:12 INFO - 'talos_options': ['--xperf_path', 12:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:12 INFO - 'tests': ['tp5n']}}, 12:22:12 INFO - 'talos.zip': {'path': '', 12:22:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:22:12 INFO - Running post-action listener: _resource_record_post_action 12:22:12 INFO - [mozharness: 2017-01-05 20:22:12.870063Z] Finished populate-webroot step (success) 12:22:12 INFO - [mozharness: 2017-01-05 20:22:12.870157Z] Running create-virtualenv step. 12:22:12 INFO - Running pre-action listener: _resource_record_pre_action 12:22:12 INFO - Running main action method: create_virtualenv 12:22:12 INFO - Creating virtualenv /builds/slave/test/build/venv 12:22:12 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 12:22:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:22:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:22:12 INFO - Using real prefix '/usr' 12:22:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:22:13 INFO - Installing distribute.............................................................................................................................................................................................done. 12:22:15 INFO - Installing pip.................done. 12:22:15 INFO - Return code: 0 12:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:22:15 INFO - Reading from file tmpfile_stdout 12:22:15 INFO - Output received: 12:22:15 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) 12:22:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:22:15 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')]} 12:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:15 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')]} 12:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:15 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:15 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 12:22:15 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 12:22:15 INFO - Using env: {'DISPLAY': ':0', 12:22:15 INFO - 'HOME': '/home/cltbld', 12:22:15 INFO - 'LANG': 'en_US.UTF-8', 12:22:15 INFO - 'LANGUAGE': 'en_US:en', 12:22:15 INFO - 'LOGNAME': 'cltbld', 12:22:15 INFO - 'MAIL': '/var/mail/cltbld', 12:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:15 INFO - 'MOZ_NO_REMOTE': '1', 12:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:15 INFO - 'NO_EM_RESTART': '1', 12:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:15 INFO - 'PWD': '/builds/slave/test', 12:22:15 INFO - 'SHELL': '/bin/bash', 12:22:15 INFO - 'SHLVL': '1', 12:22:15 INFO - 'TERM': 'linux', 12:22:15 INFO - 'TMOUT': '86400', 12:22:15 INFO - 'USER': 'cltbld', 12:22:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:15 INFO - '_': '/tools/buildbot/bin/python'} 12:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:15 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 12:22:15 INFO - Cleaning up... 12:22:15 INFO - Return code: 0 12:22:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:22:15 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')]} 12:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:15 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')]} 12:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:15 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:15 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 12:22:15 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 12:22:15 INFO - Using env: {'DISPLAY': ':0', 12:22:15 INFO - 'HOME': '/home/cltbld', 12:22:15 INFO - 'LANG': 'en_US.UTF-8', 12:22:15 INFO - 'LANGUAGE': 'en_US:en', 12:22:15 INFO - 'LOGNAME': 'cltbld', 12:22:15 INFO - 'MAIL': '/var/mail/cltbld', 12:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:15 INFO - 'MOZ_NO_REMOTE': '1', 12:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:15 INFO - 'NO_EM_RESTART': '1', 12:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:15 INFO - 'PWD': '/builds/slave/test', 12:22:15 INFO - 'SHELL': '/bin/bash', 12:22:15 INFO - 'SHLVL': '1', 12:22:15 INFO - 'TERM': 'linux', 12:22:15 INFO - 'TMOUT': '86400', 12:22:15 INFO - 'USER': 'cltbld', 12:22:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:15 INFO - '_': '/tools/buildbot/bin/python'} 12:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:16 INFO - Downloading/unpacking psutil>=3.1.1 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:18 INFO - Installing collected packages: psutil 12:22:18 INFO - Running setup.py install for psutil 12:22:18 INFO - building 'psutil._psutil_linux' extension 12:22:18 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 12:22:18 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 12:22:18 INFO - building 'psutil._psutil_posix' extension 12:22:18 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 12:22:18 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 12:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:18 INFO - Successfully installed psutil 12:22:18 INFO - Cleaning up... 12:22:18 INFO - Return code: 0 12:22:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:22:18 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')]} 12:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:18 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')]} 12:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:18 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:18 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 12:22:18 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 12:22:18 INFO - Using env: {'DISPLAY': ':0', 12:22:18 INFO - 'HOME': '/home/cltbld', 12:22:18 INFO - 'LANG': 'en_US.UTF-8', 12:22:18 INFO - 'LANGUAGE': 'en_US:en', 12:22:18 INFO - 'LOGNAME': 'cltbld', 12:22:18 INFO - 'MAIL': '/var/mail/cltbld', 12:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:18 INFO - 'MOZ_NO_REMOTE': '1', 12:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:18 INFO - 'NO_EM_RESTART': '1', 12:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:18 INFO - 'PWD': '/builds/slave/test', 12:22:18 INFO - 'SHELL': '/bin/bash', 12:22:18 INFO - 'SHLVL': '1', 12:22:18 INFO - 'TERM': 'linux', 12:22:18 INFO - 'TMOUT': '86400', 12:22:18 INFO - 'USER': 'cltbld', 12:22:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:18 INFO - '_': '/tools/buildbot/bin/python'} 12:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:22:18 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 12:22:18 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 12:22:18 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 12:22:18 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 12:22:18 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 12:22:18 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 12:22:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:22:21 INFO - Installing collected packages: mozsystemmonitor 12:22:21 INFO - Running setup.py install for mozsystemmonitor 12:22:21 INFO - Successfully installed mozsystemmonitor 12:22:21 INFO - Cleaning up... 12:22:21 INFO - Return code: 0 12:22:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:22:21 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')]} 12:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:21 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')]} 12:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:21 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:21 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 12:22:21 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 12:22:21 INFO - Using env: {'DISPLAY': ':0', 12:22:21 INFO - 'HOME': '/home/cltbld', 12:22:21 INFO - 'LANG': 'en_US.UTF-8', 12:22:21 INFO - 'LANGUAGE': 'en_US:en', 12:22:21 INFO - 'LOGNAME': 'cltbld', 12:22:21 INFO - 'MAIL': '/var/mail/cltbld', 12:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:21 INFO - 'MOZ_NO_REMOTE': '1', 12:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:21 INFO - 'NO_EM_RESTART': '1', 12:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:21 INFO - 'PWD': '/builds/slave/test', 12:22:21 INFO - 'SHELL': '/bin/bash', 12:22:21 INFO - 'SHLVL': '1', 12:22:21 INFO - 'TERM': 'linux', 12:22:21 INFO - 'TMOUT': '86400', 12:22:21 INFO - 'USER': 'cltbld', 12:22:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:21 INFO - '_': '/tools/buildbot/bin/python'} 12:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:21 INFO - Downloading/unpacking jsonschema==2.5.1 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:22:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:22:23 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 12:22:23 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 12:22:23 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 12:22:23 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 12:22:23 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 12:22:23 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 12:22:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:22:23 INFO - warning: no files found matching '*.txt' 12:22:23 INFO - no previously-included directories found matching 'build' 12:22:23 INFO - no previously-included directories found matching 'dist' 12:22:23 INFO - no previously-included directories found matching '.git*' 12:22:23 INFO - Installing collected packages: jsonschema, functools32 12:22:23 INFO - Running setup.py install for functools32 12:22:23 INFO - warning: no files found matching '*.txt' 12:22:23 INFO - no previously-included directories found matching 'build' 12:22:23 INFO - no previously-included directories found matching 'dist' 12:22:23 INFO - no previously-included directories found matching '.git*' 12:22:23 INFO - Successfully installed jsonschema functools32 12:22:23 INFO - Cleaning up... 12:22:23 INFO - Return code: 0 12:22:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:22:23 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')]} 12:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:23 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')]} 12:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:23 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:23 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 12:22:23 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 12:22:23 INFO - Using env: {'DISPLAY': ':0', 12:22:23 INFO - 'HOME': '/home/cltbld', 12:22:23 INFO - 'LANG': 'en_US.UTF-8', 12:22:23 INFO - 'LANGUAGE': 'en_US:en', 12:22:23 INFO - 'LOGNAME': 'cltbld', 12:22:23 INFO - 'MAIL': '/var/mail/cltbld', 12:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:23 INFO - 'MOZ_NO_REMOTE': '1', 12:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:23 INFO - 'NO_EM_RESTART': '1', 12:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:23 INFO - 'PWD': '/builds/slave/test', 12:22:23 INFO - 'SHELL': '/bin/bash', 12:22:23 INFO - 'SHLVL': '1', 12:22:23 INFO - 'TERM': 'linux', 12:22:23 INFO - 'TMOUT': '86400', 12:22:23 INFO - 'USER': 'cltbld', 12:22:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:23 INFO - '_': '/tools/buildbot/bin/python'} 12:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:22:24 INFO - Cleaning up... 12:22:24 INFO - Return code: 0 12:22:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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', '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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:22: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 blobuploader==1.2.4 12:22:24 INFO - Using env: {'DISPLAY': ':0', 12:22:24 INFO - 'HOME': '/home/cltbld', 12:22:24 INFO - 'LANG': 'en_US.UTF-8', 12:22:24 INFO - 'LANGUAGE': 'en_US:en', 12:22:24 INFO - 'LOGNAME': 'cltbld', 12:22:24 INFO - 'MAIL': '/var/mail/cltbld', 12:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:24 INFO - 'MOZ_NO_REMOTE': '1', 12:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:24 INFO - 'NO_EM_RESTART': '1', 12:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:24 INFO - 'PWD': '/builds/slave/test', 12:22:24 INFO - 'SHELL': '/bin/bash', 12:22:24 INFO - 'SHLVL': '1', 12:22:24 INFO - 'TERM': 'linux', 12:22:24 INFO - 'TMOUT': '86400', 12:22:24 INFO - 'USER': 'cltbld', 12:22:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:24 INFO - '_': '/tools/buildbot/bin/python'} 12:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:24 INFO - Downloading/unpacking blobuploader==1.2.4 12:22:24 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 12:22:24 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 12:22:24 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 12:22:24 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 12:22:24 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 12:22:24 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 12:22:26 INFO - Downloading blobuploader-1.2.4.tar.gz 12:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:22:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:22:26 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 12:22:26 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 12:22:26 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 12:22:26 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 12:22:26 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 12:22:26 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 12:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:22:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:22:26 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 12:22:26 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 12:22:26 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 12:22:26 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 12:22:26 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 12:22:26 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 12:22:27 INFO - Downloading docopt-0.6.1.tar.gz 12:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:22:27 INFO - Installing collected packages: blobuploader, requests, docopt 12:22:27 INFO - Running setup.py install for blobuploader 12:22:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:22:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:22:27 INFO - Running setup.py install for requests 12:22:27 INFO - Running setup.py install for docopt 12:22:27 INFO - Successfully installed blobuploader requests docopt 12:22:27 INFO - Cleaning up... 12:22:27 INFO - Return code: 0 12:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:27 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')]} 12:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:27 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')]} 12:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:27 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:27 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 12:22:27 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 12:22:27 INFO - Using env: {'DISPLAY': ':0', 12:22:27 INFO - 'HOME': '/home/cltbld', 12:22:27 INFO - 'LANG': 'en_US.UTF-8', 12:22:27 INFO - 'LANGUAGE': 'en_US:en', 12:22:27 INFO - 'LOGNAME': 'cltbld', 12:22:27 INFO - 'MAIL': '/var/mail/cltbld', 12:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:27 INFO - 'MOZ_NO_REMOTE': '1', 12:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:27 INFO - 'NO_EM_RESTART': '1', 12:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:27 INFO - 'PWD': '/builds/slave/test', 12:22:27 INFO - 'SHELL': '/bin/bash', 12:22:27 INFO - 'SHLVL': '1', 12:22:27 INFO - 'TERM': 'linux', 12:22:27 INFO - 'TMOUT': '86400', 12:22:27 INFO - 'USER': 'cltbld', 12:22:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:27 INFO - '_': '/tools/buildbot/bin/python'} 12:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:28 INFO - Running setup.py (path:/tmp/pip-rkJc71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:28 INFO - Running setup.py (path:/tmp/pip-BxfyY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:28 INFO - Running setup.py (path:/tmp/pip-a3MMFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:28 INFO - Running setup.py (path:/tmp/pip-H6GA8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:28 INFO - Running setup.py (path:/tmp/pip-xMH95d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:28 INFO - Running setup.py (path:/tmp/pip-r6Ku8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:28 INFO - Running setup.py (path:/tmp/pip-fXkG54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:28 INFO - Running setup.py (path:/tmp/pip-g1MJQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:28 INFO - Running setup.py (path:/tmp/pip-L94Ac3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:28 INFO - Running setup.py (path:/tmp/pip-QW4Dtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:28 INFO - Running setup.py (path:/tmp/pip-2fWge6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:28 INFO - Running setup.py (path:/tmp/pip-fSeiX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:28 INFO - Running setup.py (path:/tmp/pip-5jUEJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:28 INFO - Running setup.py (path:/tmp/pip-iXG9zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:29 INFO - Running setup.py (path:/tmp/pip-oXpOhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:29 INFO - Running setup.py (path:/tmp/pip-vBnrhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:29 INFO - Running setup.py (path:/tmp/pip-df_uWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:22:29 INFO - Running setup.py install for manifestparser 12:22:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for mozcrash 12:22:29 INFO - Running setup.py install for mozdebug 12:22:29 INFO - Running setup.py install for mozdevice 12:22:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for mozfile 12:22:29 INFO - Running setup.py install for mozhttpd 12:22:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for mozinfo 12:22:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:22:29 INFO - Running setup.py install for mozInstall 12:22:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Running setup.py install for mozleak 12:22:30 INFO - Running setup.py install for mozlog 12:22:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Running setup.py install for moznetwork 12:22:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Running setup.py install for mozprocess 12:22:30 INFO - Running setup.py install for mozprofile 12:22:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Running setup.py install for mozrunner 12:22:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:22:30 INFO - Running setup.py install for mozscreenshot 12:22:30 INFO - Running setup.py install for moztest 12:22:30 INFO - Running setup.py install for mozversion 12:22:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:22:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:22:31 INFO - Cleaning up... 12:22:31 INFO - Return code: 0 12:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:31 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')]} 12:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:31 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')]} 12:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:31 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:31 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 12:22:31 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 12:22:31 INFO - Using env: {'DISPLAY': ':0', 12:22:31 INFO - 'HOME': '/home/cltbld', 12:22:31 INFO - 'LANG': 'en_US.UTF-8', 12:22:31 INFO - 'LANGUAGE': 'en_US:en', 12:22:31 INFO - 'LOGNAME': 'cltbld', 12:22:31 INFO - 'MAIL': '/var/mail/cltbld', 12:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:31 INFO - 'MOZ_NO_REMOTE': '1', 12:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:31 INFO - 'NO_EM_RESTART': '1', 12:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:31 INFO - 'PWD': '/builds/slave/test', 12:22:31 INFO - 'SHELL': '/bin/bash', 12:22:31 INFO - 'SHLVL': '1', 12:22:31 INFO - 'TERM': 'linux', 12:22:31 INFO - 'TMOUT': '86400', 12:22:31 INFO - 'USER': 'cltbld', 12:22:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:31 INFO - '_': '/tools/buildbot/bin/python'} 12:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:31 INFO - Running setup.py (path:/tmp/pip-GbKZeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:31 INFO - Running setup.py (path:/tmp/pip-H7gCTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:31 INFO - Running setup.py (path:/tmp/pip-Z0J2UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:31 INFO - Running setup.py (path:/tmp/pip-NITFNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:31 INFO - Running setup.py (path:/tmp/pip-1SdBpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:31 INFO - Running setup.py (path:/tmp/pip-M6DIsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:31 INFO - Running setup.py (path:/tmp/pip-VDS4K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:31 INFO - Running setup.py (path:/tmp/pip-FNEnKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:31 INFO - Running setup.py (path:/tmp/pip-2u3Pnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:31 INFO - Running setup.py (path:/tmp/pip-Jc5CVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:31 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)) 12:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:31 INFO - Running setup.py (path:/tmp/pip-1_qPYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:32 INFO - Running setup.py (path:/tmp/pip-LGyuqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:32 INFO - Running setup.py (path:/tmp/pip-fOWq0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:32 INFO - Running setup.py (path:/tmp/pip-16pyeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:32 INFO - Running setup.py (path:/tmp/pip-GOIpOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:32 INFO - Running setup.py (path:/tmp/pip-cmlVxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:32 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)) 12:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:32 INFO - Running setup.py (path:/tmp/pip-ZmMEYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:32 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)) 12:22:32 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)) 12:22:32 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)) 12:22:32 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)) 12:22:32 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)) 12:22:32 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)) 12:22:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:22:32 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 12:22:32 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 12:22:32 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 12:22:32 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 12:22:32 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 12:22:32 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 12:22:34 INFO - Downloading blessings-1.6.tar.gz 12:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:22:34 INFO - Installing collected packages: blessings 12:22:34 INFO - Running setup.py install for blessings 12:22:34 INFO - Successfully installed blessings 12:22:34 INFO - Cleaning up... 12:22:34 INFO - Return code: 0 12:22:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:34 INFO - Reading from file tmpfile_stdout 12:22:34 INFO - Current package versions: 12:22:34 INFO - argparse == 1.2.1 12:22:34 INFO - blessings == 1.6 12:22:34 INFO - blobuploader == 1.2.4 12:22:34 INFO - docopt == 0.6.1 12:22:34 INFO - functools32 == 3.2.3-2 12:22:34 INFO - jsonschema == 2.5.1 12:22:34 INFO - manifestparser == 1.1 12:22:34 INFO - mozInstall == 1.12 12:22:34 INFO - mozcrash == 1.0 12:22:34 INFO - mozdebug == 0.1 12:22:34 INFO - mozdevice == 0.49 12:22:34 INFO - mozfile == 1.2 12:22:34 INFO - mozhttpd == 0.7 12:22:34 INFO - mozinfo == 0.9 12:22:34 INFO - mozleak == 0.1 12:22:34 INFO - mozlog == 3.4 12:22:34 INFO - moznetwork == 0.27 12:22:34 INFO - mozprocess == 0.23 12:22:34 INFO - mozprofile == 0.28 12:22:34 INFO - mozrunner == 6.13 12:22:34 INFO - mozscreenshot == 0.1 12:22:34 INFO - mozsystemmonitor == 0.3 12:22:34 INFO - moztest == 0.8 12:22:34 INFO - mozversion == 1.4 12:22:34 INFO - psutil == 3.1.1 12:22:34 INFO - requests == 1.2.3 12:22:34 INFO - wsgiref == 0.1.2 12:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:34 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:34 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 12:22:34 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 12:22:34 INFO - Using env: {'DISPLAY': ':0', 12:22:34 INFO - 'HOME': '/home/cltbld', 12:22:34 INFO - 'LANG': 'en_US.UTF-8', 12:22:34 INFO - 'LANGUAGE': 'en_US:en', 12:22:34 INFO - 'LOGNAME': 'cltbld', 12:22:34 INFO - 'MAIL': '/var/mail/cltbld', 12:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:34 INFO - 'MOZ_NO_REMOTE': '1', 12:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:34 INFO - 'NO_EM_RESTART': '1', 12:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:34 INFO - 'PWD': '/builds/slave/test', 12:22:34 INFO - 'SHELL': '/bin/bash', 12:22:34 INFO - 'SHLVL': '1', 12:22:34 INFO - 'TERM': 'linux', 12:22:34 INFO - 'TMOUT': '86400', 12:22:34 INFO - 'USER': 'cltbld', 12:22:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:34 INFO - '_': '/tools/buildbot/bin/python'} 12:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 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)) 12:22:35 INFO - Cleaning up... 12:22:35 INFO - Return code: 0 12:22:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:22:35 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')]} 12:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:35 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')]} 12:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:35 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 0x26891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2855a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, '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': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', '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 12:22:35 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 12:22:35 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 12:22:35 INFO - Using env: {'DISPLAY': ':0', 12:22:35 INFO - 'HOME': '/home/cltbld', 12:22:35 INFO - 'LANG': 'en_US.UTF-8', 12:22:35 INFO - 'LANGUAGE': 'en_US:en', 12:22:35 INFO - 'LOGNAME': 'cltbld', 12:22:35 INFO - 'MAIL': '/var/mail/cltbld', 12:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:35 INFO - 'MOZ_NO_REMOTE': '1', 12:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:35 INFO - 'NO_EM_RESTART': '1', 12:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:35 INFO - 'PWD': '/builds/slave/test', 12:22:35 INFO - 'SHELL': '/bin/bash', 12:22:35 INFO - 'SHLVL': '1', 12:22:35 INFO - 'TERM': 'linux', 12:22:35 INFO - 'TMOUT': '86400', 12:22:35 INFO - 'USER': 'cltbld', 12:22:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:35 INFO - '_': '/tools/buildbot/bin/python'} 12:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:22:35 INFO - Cleaning up... 12:22:35 INFO - Return code: 0 12:22:35 INFO - Running post-action listener: _resource_record_post_action 12:22:35 INFO - Running post-action listener: _start_resource_monitoring 12:22:35 INFO - Starting resource monitoring. 12:22:35 INFO - [mozharness: 2017-01-05 20:22:35.468563Z] Finished create-virtualenv step (success) 12:22:35 INFO - [mozharness: 2017-01-05 20:22:35.469070Z] Running install step. 12:22:35 INFO - Running pre-action listener: _resource_record_pre_action 12:22:35 INFO - Running main action method: install 12:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:35 INFO - Reading from file tmpfile_stdout 12:22:35 INFO - Detecting whether we're running mozinstall >=1.0... 12:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:22:35 INFO - Reading from file tmpfile_stdout 12:22:35 INFO - Output received: 12:22:35 INFO - Usage: mozinstall [options] installer 12:22:35 INFO - Options: 12:22:35 INFO - -h, --help show this help message and exit 12:22:35 INFO - -d DEST, --destination=DEST 12:22:35 INFO - Directory to install application into. [default: 12:22:35 INFO - "/builds/slave/test"] 12:22:35 INFO - --app=APP Application being installed. [default: firefox] 12:22:35 INFO - mkdir: /builds/slave/test/build/application 12:22:35 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'] 12:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:22:51 INFO - Reading from file tmpfile_stdout 12:22:51 INFO - Output received: 12:22:51 INFO - /builds/slave/test/build/application/firefox/firefox 12:22:51 INFO - Running post-action listener: _resource_record_post_action 12:22:51 INFO - [mozharness: 2017-01-05 20:22:51.858354Z] Finished install step (success) 12:22:51 INFO - [mozharness: 2017-01-05 20:22:51.858625Z] Running run-tests step. 12:22:51 INFO - Running pre-action listener: _resource_record_pre_action 12:22:51 INFO - Running main action method: run_tests 12:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:22:51 INFO - Python 2.7.3 12:22:51 INFO - Return code: 0 12:22:51 INFO - grabbing minidump binary from tooltool 12:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:51 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 0x29f83f0>, '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 0x29f8cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f91a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:22:51 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 12:22:51 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 12:22:51 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 12:22:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:22:51 INFO - Return code: 0 12:22:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:22:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:22:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:22:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:22:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:22:51 INFO - Using env: {'DISPLAY': ':0', 12:22:51 INFO - 'HOME': '/home/cltbld', 12:22:51 INFO - 'LANG': 'en_US.UTF-8', 12:22:51 INFO - 'LANGUAGE': 'en_US:en', 12:22:51 INFO - 'LOGNAME': 'cltbld', 12:22:51 INFO - 'MAIL': '/var/mail/cltbld', 12:22:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:22:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:51 INFO - 'MOZ_NO_REMOTE': '1', 12:22:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:51 INFO - 'NO_EM_RESTART': '1', 12:22:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:51 INFO - 'PWD': '/builds/slave/test', 12:22:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:22:51 INFO - 'SHELL': '/bin/bash', 12:22:51 INFO - 'SHLVL': '1', 12:22:51 INFO - 'TERM': 'linux', 12:22:51 INFO - 'TMOUT': '86400', 12:22:51 INFO - 'USER': 'cltbld', 12:22:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513', 12:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:51 INFO - '_': '/tools/buildbot/bin/python'} 12:22:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:22:52 INFO - mozversion application_buildid: 20170105194941 12:22:52 INFO - mozversion application_changeset: a208bb74042cdb0a434d4c85f9b7640126be863c 12:22:52 INFO - mozversion application_display_name: Nightly 12:22:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:22:52 INFO - mozversion application_name: Firefox 12:22:52 INFO - mozversion application_remotingname: firefox 12:22:52 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:22:52 INFO - mozversion application_vendor: Mozilla 12:22:52 INFO - mozversion application_version: 53.0a1 12:22:52 INFO - mozversion platform_buildid: 20170105194941 12:22:52 INFO - mozversion platform_changeset: a208bb74042cdb0a434d4c85f9b7640126be863c 12:22:52 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:22:52 INFO - mozversion platform_version: 53.0a1 12:22:52 INFO - using testdate: 1483647772 12:22:52 INFO - actual date: 1483647772 12:22:52 INFO - starting webserver on 'localhost:41052' 12:22:52 INFO - SUITE-START | Running 2 tests 12:22:52 INFO - TEST-START | dromaeo_css 12:22:52 INFO - operating with platform_type : linux_ 12:22:52 INFO - Initialising browser for dromaeo_css test... 12:22:52 INFO - TEST-INFO | started process 2073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSxkfhn/profile http://localhost:41052/getInfo.html) 12:22:52 INFO - PROCESS | 2073 | 1483647772640 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 12:22:56 INFO - PROCESS | 2073 | __metrics Screen width/height:1600/1200 12:22:56 INFO - PROCESS | 2073 | colorDepth:24 12:22:56 INFO - PROCESS | 2073 | Browser inner width/height: 1024/697 12:22:56 INFO - PROCESS | 2073 | __metrics 12:22:57 ERROR - PROCESS | 2073 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 12:22:58 INFO - TEST-INFO | 2073: exit 0 12:22:58 INFO - Browser initialized. 12:22:58 INFO - Running cycle 1/1 for dromaeo_css test... 12:22:58 INFO - TEST-INFO | started process 2193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSxkfhn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:10 INFO - PROCESS | 2193 | RSS: Main: 158380032 12:23:10 INFO - PROCESS | 2193 | 12:23:59 INFO - PROCESS | 2193 | 1483647839702 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:26:14 INFO - PROCESS | 2193 | Cycle 1(1): loaded http://localhost:41052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41052/tests/dromaeo/cssquery-ext.html) 12:26:15 INFO - PROCESS | 2193 | RSS: Main: 165666816 12:26:15 INFO - PROCESS | 2193 | 12:27:58 INFO - PROCESS | 2193 | ************************* 12:27:58 INFO - PROCESS | 2193 | A coding exception was thrown and uncaught in a Task. 12:27:58 INFO - PROCESS | 2193 | 12:27:58 INFO - PROCESS | 2193 | Full message: ReferenceError: fetch is not defined 12:27:58 INFO - PROCESS | 2193 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 12:27:58 INFO - PROCESS | 2193 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 12:27:58 INFO - PROCESS | 2193 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 12:27:58 INFO - PROCESS | 2193 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 12:27:58 INFO - PROCESS | 2193 | TaskImpl@resource://gre/modules/Task.jsm:277:3 12:27:58 INFO - PROCESS | 2193 | asyncFunction@resource://gre/modules/Task.jsm:252:14 12:27:58 INFO - PROCESS | 2193 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 12:27:58 INFO - PROCESS | 2193 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 12:27:58 INFO - PROCESS | 2193 | TaskImpl@resource://gre/modules/Task.jsm:277:3 12:27:58 INFO - PROCESS | 2193 | asyncFunction@resource://gre/modules/Task.jsm:252:14 12:27:58 INFO - PROCESS | 2193 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 12:27:58 INFO - PROCESS | 2193 | 12:27:58 INFO - PROCESS | 2193 | ************************* 12:29:17 INFO - PROCESS | 2193 | Cycle 1(1): loaded http://localhost:41052/tests/dromaeo/cssquery-ext.html (next: http://localhost:41052/tests/dromaeo/cssquery-jquery.html) 12:29:18 INFO - PROCESS | 2193 | RSS: Main: 163250176 12:29:18 INFO - PROCESS | 2193 | 12:32:20 INFO - PROCESS | 2193 | Cycle 1(1): loaded http://localhost:41052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41052/tests/dromaeo/cssquery-mootools.html) 12:32:21 INFO - PROCESS | 2193 | RSS: Main: 168370176 12:32:21 INFO - PROCESS | 2193 | 12:35:23 INFO - PROCESS | 2193 | Cycle 1(1): loaded http://localhost:41052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41052/tests/dromaeo/cssquery-prototype.html) 12:35:24 INFO - PROCESS | 2193 | RSS: Main: 163205120 12:35:24 INFO - PROCESS | 2193 | 12:38:26 INFO - PROCESS | 2193 | Cycle 1(1): loaded http://localhost:41052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41052/tests/dromaeo/cssquery-yui.html) 12:38:27 INFO - PROCESS | 2193 | RSS: Main: 166559744 12:38:27 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | Cycle 1(1): loaded http://localhost:41052/tests/dromaeo/cssquery-yui.html (next: http://localhost:41052/tests/dromaeo/cssquery-dojo.html) 12:41:30 INFO - PROCESS | 2193 | RSS: Main: 167251968 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | __start_tp_report 12:41:30 INFO - PROCESS | 2193 | _x_x_mozilla_page_load 12:41:30 INFO - PROCESS | 2193 | _x_x_mozilla_page_load_details 12:41:30 INFO - PROCESS | 2193 | |i|pagename|runs| 12:41:30 INFO - PROCESS | 2193 | |0;dojo.html;2602.7006894207148;2604.661394018778;2606.934826629334;2637.5120602688503;2657.083306259341;4761.2143996240575;4846.4668886422505;4877.536634019772;4894.216925291954;4917.606591472673;4770.499097594755;4807.471178170398;4846;4850.393700787402;4883.9755801220945;4371.956280437194;4420.690551661385;4446.288593824988;4520.638348932078;4556.339330797033;4054.2499637567;4485.955140448603;4489.147062058215;4501.369808226835;4501.482329532113;4337.739735615842;4448.733076015449;4472.463304403493;4490.640748740093;4577.473590537081;4341.1100724351745;4385.583369579885;4433.202023635744;4437.822487100512;4520.434945631796;4397.2304846651705;4421.93873470368;4440.777961101932;4445;4457.041736026737;4777.211760059586;4807.375041244651;4838.661293709441;4845.200541910581;4865.732384718839;4991.550760431543;5028.622853286018;5059.367579052619;5068.518490743373;5109.770060347293;5172.250023746573;5173.870653233662;5174.818881339173;5182.637215394924;5240.973795131038;4830.468648448667;4836.733979631119;4860.80556777732;4864.027194561102;4886.413630364379;5213.661112027706;5259.710715910585;5263.105272103751;5273.1299335609965;5292.7353632319;4964.404271487445;4993.176125939252;5019.47295533971;5025.14572522672;5055.8988820223385;5091.949080509147;5095.617828662865;5103.8468845934685;5121.692698438105;5129.281900533928;5020.146575082172;5053.46938571452;5060.645754797129;5067.366579177603;5073.315102461194;5058.215976523645;5062.215356619729;5065.265536497261;5071.873203169876;5094.643374963791;4293.720908140961;4315.395844581761;4327.307630779061;4329.480462344539;4336.869893903188;3781.810909454516;3804.2201348723447;3835.7890316032326;3902.941455878164;3907.843686252575;4440.289553671461;4441.489228738672;4446.221911165598;4460.219461594273;4487.753173575485;5044.419891712427;5072.82245121419;5197.116490196676;5205.063088644005;5214.478552144755;4385.210662080793;4407.2507673695545;4421.734695918255;4443.066955939289;4482.955170448319;4644.0944015916575;4646.79089440976;4653.534646535387;4662.813487460531;4696.694714843524;4778.617710583145;4785.952140478551;4793.904121917542;4800.807967681254;4840.201366774513;5016.347874776256;5065.696058236517;5087.109755792795;5118.155504341742;5130.769115389891;4763.976180119077;4772.832950846704;4785.808567657394;4813.350197723263;4813.989062296957;5079.873003174803;5081.796728130981;5093.286939828353;5099.3370861787735;5101.770420331169;4972.975135124301;5013.147764879906;5113.079645663816;5149.588032957279;5187.610929180402;4983.526564976321;5007.273945277987;5019.824306149268;5025.095482813129;5033.219850923113;4921.557059864629;4967.304577359245;4993.375828021497;5004.824831130893;5023.8492845214705;4885.1206782779445;4953.554180123806;4969.453360130455;4984.626153038609;5004.649674522749;4933.407991041098;4951.306817045688;4963.205887058053;4974.701517908937;5003.499650034967;4870;4878.512148785093;4894.951050489592;4900.166971614763;4909.926351104665 12:41:30 INFO - PROCESS | 2193 | |1;ext.html;513.8047541934066;519.5661622545177;527.1854984049643;537.4705914674046;550.859530819641;38976.415353769684;41164.38253426201;41272.58727412725;41288.58711412885;44611.33083003757;40874.38688419668;41258.381124283085;41742.58257417425;41812;41910.58089419105;7785.961070194655;7913.0899946506315;7952.125266220711;7971.840563188733;9581.377210481296;9473.384230025027;9716.465594392306;9727.90272097277;9730.805383892319;9747.074027967366;9748.610055597768;9760.4631745254;9765.658201962933;9829.410235385863;9838.754031149243;9663.758406039835;9714.805703885882;9723.319367644268;9731.075547823017;9771.951140244253;9736.853947190797;9742.269329800223;9784.657536986171;9795.510224488748;9800.90199098007;33443.83278083594;33601;33805.49291760626;33922.91156326546;33929;3589.6230895756094;3628.4013137832226;3666.120131168527;3669.504616876714;3673.687736542397;25363.87318063398;25950;25981.610275845876;26056.60915086275;26335.34161645974;3395.2190996070794;3412.6246112927556;3418;3434.7767395119236;3458.3083383323437;238216;241306;242608;243570;244156;45912;46266.30600540995;46432.7678361606;46528.06943861172;46633.53366466292;48623.27065094026;48679;48738.512614874104;48752.26871596929;48768.51231487711;12325.137240393266;12590.307533085768;12624.116311858083;12640.620781376574;12646.114771965875;8399.70601028961;8580.871286930576;9018.819623607491;9222.40054396462;9531.428114313163;15632.609184770245;15637.3745050199;15753.606159846095;15820.367185312689;15902.363905443885;6499.577527460794;6500.9349906501275;6629.635370054693;6715.4291885190305;6798.694058767268;776.8679324514846;802.7070119406375;805.472415567804;806.7055524733547;812.4028838803474;26462.20613381563;27031.86484067567;27900.581491277648;28005;28143.71856281452;928.6563971330515;955.1308309438516;958.2334132693817;965.4979410706393;967.2358836519212;14337.856621433652;14895.180765057808;14961.551153465414;15085.849141508445;15209.239538023054;352185;355251;356992;357188;358036;50460.747696261285;50977.490225098016;51079.48920510821;51144.488555114716;51242.48757512377;1201.7596480703894;1222.8165775133623;1229.4037391864938;1241.5468354050888;1243.881831226032;25805;26327.21018369452;26886.865565672048;26983.325416864736;27027;42684.57315426806;42973.785131074146;43020.35469468023;43077.78461107674;43182.56817431786;291217;292697.48583940894;292828;293055;295021;22993.195238167253;23475.178368757013;23498;24872.751272487043;25662.486750264517;35453.290934181685;35594.46608300929;36171;36207.456888146175;36356.272874541835;30532.389352213275;30691;31063;31438.528422074145;31618.051458456284;26820;27213.727862721913;27390;27445.176644700692;27492;30368.84815575908;30455.543166852072;30703.69296307098;30908.845455772578;30927;27339.179824605293;28518.714812851606;28771.856140719163;28782.280442989093;28844;22027.559448811255;22146.557068858212;22163.77836221617;22221.777782222616;22316.77683223147 12:41:30 INFO - PROCESS | 2193 | |2;jquery.html;364.62261559286134;367.3332900785075;368.08778396231577;382.2660491855637;385.8726620215329;16926.830731692695;18292.176852041655;18754.906225468854;18854.62290754186;18977.715334269997;17406.564835879108;17804.910975445106;17858.64282714345;18040.458786236402;18252.17865196066;5022.19644856823;5230.633855630107;5234.136367499358;5237.528622423981;5243.318368612075;4948.505149485059;5054.671446355975;5093.108705976458;5093.974530127362;5118.360204974379;5057.6965382077005;5071.644984851062;5078.162103252977;5081.517255860687;5097.362829646294;4921.311016457699;5081.314022606938;5144.897102057976;5162.354705661793;5176.0683077046115;4575.039241759235;4575.565321294472;4582.977085114587;4584.564466375722;4589.977050114761;18126.365577204735;21441.571168576542;21506.247281345077;21510;21644.458888527755;2295.5753185660706;2352.8235382346393;2397.7961873240797;2404.843685160459;2410.2166795791436;13415.597532074053;13490.595282141552;13617.319134043259;13672.65818354549;14103.929480352532;1730.3338214787273;1738.75657407963;1741.9041952692596;1759.1468137953082;1817.164104511926;70931;71602;72758;72791;73106;9587;9667.371620844622;9753.609855605697;9758.343150745954;9951.950240248898;12973.41619627119;13084.607461776162;13086.345682715826;13098.410571524304;13189;6703.195616526048;6907.481938854606;6964.129483814523;7044.22513523512;7107.502474826816;6411.839704007437;6475.579087359307;6611.173603299588;6616.106825578581;6674.432673222734;6243.406876346739;6308.968455157787;6363.109164716943;6416.967915160394;6491.837704057436;1732.2378153612622;1734.8178441263738;1790.0333819737195;1807.484866812952;1813.9818601814077;849.7493239494364;852.2755657691037;862.7109918177356;865.7965378136133;889.9955500222458;17571.912140439472;17655.646887062187;18076.638467230845;18206.81793182051;18660.533486662942;822.9877250981326;823.300194834398;845.471580262336;856.1096459681986;859.3254295378098;10047.799044019224;10384;10590;10659.307145035704;10686.091682206945;556967;560778;563946;563950;570208;84979.15020849713;86204;93019.53490232506;99590.50204749075;99890;947.6541062512272;982.1896935028487;984.5175863826817;986.8667729856378;989.6437282578122;16225;16254;16406.507804765875;16479.83520164783;16808.495745127664;34398.82800585981;39871;40014.932802389245;40702.79648601738;42049.78975105105;56564.43435565592;58052;59646.70176649089;60862.3482591046;60914.390856090875;7268.67290971897;7468.253174682705;7469.925300746923;7599.430042746705;7687.308142267223;11131.276467029616;11308.717282068013;11448.313101213955;12005.63983080509;12055.879441205476;9731.56207970629;9847.852282215916;10131.290809643255;10434.68695939123;10575.62985295511;10449.268551201647;10466.529006194587;10544.472776360997;10588.735281618021;10653.467326633483;9914.30599858003;10219.795604088025;10513.579456821948;10681.359118452918;10715.892841071489;7166.140063192451;7251.456140789356;7334.669939852826;7432.814179645552;7606.163322034461;9364.625414983324;9666.323357365198;10446;10673.306235094695;10706.304090234109 12:41:30 INFO - PROCESS | 2193 | |3;mootools.html;1106.314085267134;1123.5449642894625;1130.9321440713563;1141.3437273567702;1179.5635614822518;6102.847428814282;6296.6536840473755;6503;6941.444684425246;6963.408110310617;6530.738770449188;6772.627505487197;6777.7288908443725;6887.7244910203535;6889.448844092473;1800.79290881549;1818.481732706179;1823.088455772114;1824.1061879678928;1828.5097645419007;1988.7116368126613;2013.3154727392684;2030.46192758919;2032.928847490338;2082.2607974169105;2099.937001889946;2128.17001369466;2130.147940823675;2132.509522809755;2144.345974477784;1967.3212741604123;1997.900104994759;2006.8695534790193;2012.64778663734;2016.747906511686;2059.4130672758342;2064.5457999240143;2085.270155445582;2086.69742887282;2087.5303056812095;6824.1128653275255;6971;6980.720771169147;6986.685599148;6993.05593744843;4120.134771697947;4251.829926802924;4253.191893540248;4255.361695745632;4256.212600668886;2465.359006658282;2660.188642464048;2688.4623075385;2700.0819721294656;2712.4303896181827;1059.539100491281;1062.1078294232882;1102.2449622008949;1114.1866437500669;1130.5760339872547;8791.736247912573;8826.293896488265;8827.382083254175;8850.336224783166;8963.507007114606;3527.1182204448887;3617.782933024027;3693.4644476550748;3756.6431189037;3757.511523501982;7069.257727938492;7145.749898753519;7177.4258059355125;7187.065681461481;7209.279072092749;4114.280000999813;4120.958790412117;4147.212029714345;4167.937480937789;4251.723637963522;3724.795136267477;3757.774533527997;3852.6917846572205;3859.2281543691374;3860;3089.891853785107;3122.87508499662;3182.9681703182673;3224.967750322514;3226.774125811218;867.444835305405;895.9507227102441;932.137772560379;939.3565407695751;947.313197931508;620.2092332276294;622.2626187967273;632.3644737039338;637.4963778614936;643.8937575300023;4403.471583410012;4515.503294637587;4590.173768721662;4678.555537223959;4827.589654879304;852.7953291210065;881.7266647339345;885.4731434796286;885.5749240364661;887.9112088791069;3148.338848841769;3190.7287880529952;3305.471124620049;3350.0787283497234;3390.830458477116;7972.481788683717;8071.959640201879;8140.226678465537;8194.959025204955;8243;8069.7175598853755;8082.393820463371;8103.270705636521;8206.58967051645;8213.096559378464;6458.709358078898;6477.967610161919;6521.413072823469;6605.438537724252;6660.400563949171;4670.649701272486;4782.880427989328;4847.903041939071;4856.470211883246;4998.400191976986;7515.473916825769;7553.093628764584;7605.239476052572;7704.961475192588;7707.421943354158;7690.154083050972;7708.537487750753;7745.612719363897;7760.107587627269;7827.804304892423;5675.943240567542;5755.7409916553015;5758.193852860519;5772.682502462237;5783.595148339576;6453.09656648079;6467.417932386108;6515.413612774683;6567.605943643397;6577.309382514767;5912.46787789101;5923.08192230205;5955.821325360246;5970.283565972111;6013.7293821779;5527.44725527444;5584.357798853184;5589.133684278943;5590.776368945197;5601.915971260353;5397.379301380392;5410.539154428204;5438.564914806727;5453;5460.126379779216;3962.54430740457;4023.2959232134845;4055.53361363447;4130.401091841726;4171.353440216772;4097.623378440438;4130.380442933584;4218.810153543037;4225.683073769418;4266.743995360288 12:41:30 INFO - PROCESS | 2193 | |4;prototype.html;318.6701763674597;320.1260558674819;322.13185465171375;327.76892290934893;340.48416648777106;4821.228603423453;4946.230111137761;4955.776990035448;4957.652964292501;4975.328330675362;4898.951010489894;4904.730239836807;4905.950940490594;4928.802847886089;4933.7779799909;3632.4551317302353;3804.2201348723584;3807.2956503047026;3955.545112312092;3969.6427321541055;3814.8855534334016;3815.465834783133;3816.370298900678;3821.700621788605;3827.3876179811236;3794.1652836376093;3797.810109494528;3800.258949504848;3809.847606095767;3810.1808111256073;3825.158465137665;3825.387937929932;3831.501904752364;3840.884773456773;3842.250761101572;3278.2132288250887;3279.44249477587;3313.3042061167184;3316.2538428853554;3339.899803005889;4710.317004034396;4734.7689600703725;4757.500462451428;4788.449328327252;4790.4251489821445;4295.312749960022;4301.634361079312;4304.913901721948;4321.65426765858;4321.82712691492;4957.752112394366;5074.517920797555;5120.692758434506;5145.33110695611;5152.4847515248175;3596.2737885814695;3605.513255710498;3617.963820361815;3625.963740362615;3626.691731202851;5390.5418039466695;5398.946010539884;5403.2165336026055;5404.7838086476495;5431.158170483582;3526.717862570988;3631.4008188649104;3636;3644.562652481666;3661.798601076913;3635.7093231902295;3646.6353364663323;3658.487811706363;3662.2675464907124;3670.3576874046935;4240.300350442204;4240.448741663626;4247.299195632686;4248.34150706641;4258.190943720683;5147.871303217375;5163.225516172529;5172.379314482287;5177.8187763428095;5214.6610470320065;1209.7036226124656;1228.7112528555783;1231.9876801231874;1248.4194849395076;1252.2173641474078;812.6911773526023;820.4953953318666;839.8278352937633;844.2401838345538;847.6609356257546;4420.359047938031;4428;4434.268345722984;4465.330200469955;4514.480834703985;5280.867978300496;5289.3652761668845;5301.734913254322;5302.1781623848365;5303.761330740126;4500.369948207253;4506.414166158444;4516.638668906479;4534.36518887356;4546.772661366985;2686.6641669791275;2721.931951701223;2729.6587926509187;2762.4198918226994;2788.372616161388;4755.429348478136;4775.6657034007985;4777.187878060738;4780.852595377084;4829.064312585232;5227.86998271369;5276.947230527722;5277.472252774769;5291.656042357235;5305.283786688748;4542.909701671641;4732.550407711331;4738.838984448832;4774.3315935769715;4793.304970779218;5119.360079990001;5131.461196574455;5158.845234642967;5159.690418574897;5170.405403378509;5099.847004589868;5109.335786347751;5113.565346945551;5120.487951204998;5141.897162056813;4631.768411579475;4723.291506274087;4766.785494652819;4779.737114458738;4799.208130658402;3513.9297214056087;3521.612622611562;3545;3558.679718825318;3567.714582833315;5092.206306301829;5223.190405487156;5234.921476177784;5238;5241.9737901310245;4842.854714358575;5022.573081287986;5061.848144555669;5067.746612669278;5081.263216833465;4934.950650493593;5022.447530771539;5028.522290382408;5031.6729412588065;5046.84859454217;4951.430585482715;4974.427940786856;4975.527324904128;4996.100701873697;5001.24981252815;4848.587870031087;5069.923951140662;5075.771590278372;5206.245094461357;5242;4851.56335929768;4919.2129259318335;4988.80940010393;5011.498850114959;5017.1721665924715 12:41:30 INFO - PROCESS | 2193 | |5;yui.html;638.3903372279474;656.9343065693434;719.9748008819693;726.7964969808453;762.8283636181858;12828.294443805598;13380.59858204253;13437;13499.66250843728;13539;12765.80851287229;12797.936010319936;12888.548900788473;12950.805737913939;12994.54519091832;800.7877912353216;811.9106898241189;818.607068607069;819.7008092046419;822.0587427395628;816.1145157504086;817.3134566963749;818.1859050245015;818.7134502923959;819.5451524403953;852.6845067325098;854.7521218846558;856.2764464027917;856.3021137772695;856.648774002656;845.957702114898;846.5851732651018;846.9534175620338;848.2789628815519;849.6049337058266;621.4655396359127;625.0530446373748;625.6902833097646;627.802242293676;629.468099455959;11602.825957610643;11611.825822612667;11709.648710538697;11718.941405293004;12124.757504849942;10647.627333043307;11153.219274650777;11206.439678016066;11672.1829471937;11771.352575608338;11733.471993760217;11860.288382697066;11957.94021029898;11962.222455540363;12573.05702072339;4050.18996200761;4062.709205543519;4113.526944401402;4114.567970363129;4124.443200167969;63753.362466375205;64780.67609661969;65356;65941.340586594;65950;9890.406575605486;10003.199744020607;10040.146587539995;10127.848082278771;10562.260641755158;17627.118644067745;17629.206685699173;17679.469615911545;17799.644007120045;18042;6109.20580324555;6140.846478838065;6165.969170154211;6204.286507051746;6238.968805156036;3402.234497238151;3446.655334466533;3449.464643487035;3462.1690794209208;3466.4800279957703;2385.6540801583674;2419.6491508731137;2433.9026438942597;2436.0377650827822;2436.707595088565;445.97993090311013;450.9233430316854;458.52084571622737;461.15608436561683;461.97690115494765;416.6812388522782;422.41917363625015;424.5711831050661;441.68860953028036;446.98882527937064;6646.86706265872;6664.600123992576;6780.627065511444;6938.618375989268;6949.652517374111;539.6095297830648;554.1272495819021;558.1516095534846;574.6092656993201;586.8708884045503;3452.5166476693284;3553.502509648651;3659.304732100892;3786.280606684721;3874.244522318177;60666.696666516385;60734.69632651897;61450;61678;62851.68574157191;35998.820005899805;39193.608063919564;47376.28935565969;54743;54824.72587637116;48677;49700.751496243014;49900.75049624729;50228;51767.48232517777;8016.679332826621;8535.743927682179;8538.957305213682;8539.487630742175;8644;34066.65933340734;35308.47037294391;36053.27893442169;36195.819020904724;36646.816765916;43627.12745745131;43936.780316098215;46441;46679.53320466752;47218;11176.664700059011;11263.096335504131;11442.942785286354;11550.711232219262;11691.181617286707;12595.622131336075;12656.74686506283;12690.302033388252;13085.803712944124;13094.869051309364;11223.775524489627;11290.548378064785;11522;11694.122940779645;11842.1710480269;11870.58452954177;11921.761564768483;12224.87775122273;12319.076069294659;12420.813687794509;12104.515819367127;12151.696207594881;12217.45021474018;12383.257004579755;12926.35368231566;10086.193104551472;10213.182945364502;10446.52990615409;10510.789784204426;10589;8560.657573697232;8709.869351959853;8835.558222089;9029.142231487998;9191.586378612845 12:41:30 INFO - PROCESS | 2193 | __end_tp_report 12:41:30 INFO - PROCESS | 2193 | __start_cc_report 12:41:30 INFO - PROCESS | 2193 | _x_x_mozilla_cycle_collect,333 12:41:30 INFO - PROCESS | 2193 | __end_cc_report 12:41:30 INFO - PROCESS | 2193 | __startTimestamp1483648890669__endTimestamp 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | ------- Summary: start ------- 12:41:30 INFO - PROCESS | 2193 | Number of tests: 6 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | [#0] dojo.html Cycles:165 Average:4741.04 Median:4878.51 stddev:493.96 (10.1%) stddev-sans-first:466.13 12:41:30 INFO - PROCESS | 2193 | Values: 2602.7 2604.7 2606.9 2637.5 2657.1 4761.2 4846.5 4877.5 4894.2 4917.6 4770.5 4807.5 4846.0 4850.4 4884.0 4372.0 4420.7 4446.3 4520.6 4556.3 4054.2 4486.0 4489.1 4501.4 4501.5 4337.7 4448.7 4472.5 4490.6 4577.5 4341.1 4385.6 4433.2 4437.8 4520.4 4397.2 4421.9 4440.8 4445.0 4457.0 4777.2 4807.4 4838.7 4845.2 4865.7 4991.6 5028.6 5059.4 5068.5 5109.8 5172.3 5173.9 5174.8 5182.6 5241.0 4830.5 4836.7 4860.8 4864.0 4886.4 5213.7 5259.7 5263.1 5273.1 5292.7 4964.4 4993.2 5019.5 5025.1 5055.9 5091.9 5095.6 5103.8 5121.7 5129.3 5020.1 5053.5 5060.6 5067.4 5073.3 5058.2 5062.2 5065.3 5071.9 5094.6 4293.7 4315.4 4327.3 4329.5 4336.9 3781.8 3804.2 3835.8 3902.9 3907.8 4440.3 4441.5 4446.2 4460.2 4487.8 5044.4 5072.8 5197.1 5205.1 5214.5 4385.2 4407.3 4421.7 4443.1 4483.0 4644.1 4646.8 4653.5 4662.8 4696.7 4778.6 4786.0 4793.9 4800.8 4840.2 5016.3 5065.7 5087.1 5118.2 5130.8 4764.0 4772.8 4785.8 4813.4 4814.0 5079.9 5081.8 5093.3 5099.3 5101.8 4973.0 5013.1 5113.1 5149.6 5187.6 4983.5 5007.3 5019.8 5025.1 5033.2 4921.6 4967.3 4993.4 5004.8 5023.8 4885.1 4953.6 4969.5 4984.6 5004.6 4933.4 4951.3 4963.2 4974.7 5003.5 4870.0 4878.5 4895.0 4900.2 4909.9 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | [#1] ext.html Cycles:180 Average:44248.58 Median:357612.00 stddev:78983.69 (22.1%) stddev-sans-first:79137.00 12:41:30 INFO - PROCESS | 2193 | Values: 513.8 519.6 527.2 537.5 550.9 38976.4 41164.4 41272.6 41288.6 44611.3 40874.4 41258.4 41742.6 41812.0 41910.6 7786.0 7913.1 7952.1 7971.8 9581.4 9473.4 9716.5 9727.9 9730.8 9747.1 9748.6 9760.5 9765.7 9829.4 9838.8 9663.8 9714.8 9723.3 9731.1 9772.0 9736.9 9742.3 9784.7 9795.5 9800.9 33443.8 33601.0 33805.5 33922.9 33929.0 3589.6 3628.4 3666.1 3669.5 3673.7 25363.9 25950.0 25981.6 26056.6 26335.3 3395.2 3412.6 3418.0 3434.8 3458.3 238216.0 241306.0 242608.0 243570.0 244156.0 45912.0 46266.3 46432.8 46528.1 46633.5 48623.3 48679.0 48738.5 48752.3 48768.5 12325.1 12590.3 12624.1 12640.6 12646.1 8399.7 8580.9 9018.8 9222.4 9531.4 15632.6 15637.4 15753.6 15820.4 15902.4 6499.6 6500.9 6629.6 6715.4 6798.7 776.9 802.7 805.5 806.7 812.4 26462.2 27031.9 27900.6 28005.0 28143.7 928.7 955.1 958.2 965.5 967.2 14337.9 14895.2 14961.6 15085.8 15209.2 352185.0 355251.0 356992.0 357188.0 358036.0 50460.7 50977.5 51079.5 51144.5 51242.5 1201.8 1222.8 1229.4 1241.5 1243.9 25805.0 26327.2 26886.9 26983.3 27027.0 42684.6 42973.8 43020.4 43077.8 43182.6 291217.0 292697.5 292828.0 293055.0 295021.0 22993.2 23475.2 23498.0 24872.8 25662.5 35453.3 35594.5 36171.0 36207.5 36356.3 30532.4 30691.0 31063.0 31438.5 31618.1 26820.0 27213.7 27390.0 27445.2 27492.0 30368.8 30455.5 30703.7 30908.8 30927.0 27339.2 28518.7 28771.9 28782.3 28844.0 22027.6 22146.6 22163.8 22221.8 22316.8 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | [#2] jquery.html Cycles:180 Average:30189.60 Median:4934.91 stddev:92526.67 (1874.9%) stddev-sans-first:92759.13 12:41:30 INFO - PROCESS | 2193 | Values: 364.6 367.3 368.1 382.3 385.9 16926.8 18292.2 18754.9 18854.6 18977.7 17406.6 17804.9 17858.6 18040.5 18252.2 5022.2 5230.6 5234.1 5237.5 5243.3 4948.5 5054.7 5093.1 5094.0 5118.4 5057.7 5071.6 5078.2 5081.5 5097.4 4921.3 5081.3 5144.9 5162.4 5176.1 4575.0 4575.6 4583.0 4584.6 4590.0 18126.4 21441.6 21506.2 21510.0 21644.5 2295.6 2352.8 2397.8 2404.8 2410.2 13415.6 13490.6 13617.3 13672.7 14103.9 1730.3 1738.8 1741.9 1759.1 1817.2 70931.0 71602.0 72758.0 72791.0 73106.0 9587.0 9667.4 9753.6 9758.3 9952.0 12973.4 13084.6 13086.3 13098.4 13189.0 6703.2 6907.5 6964.1 7044.2 7107.5 6411.8 6475.6 6611.2 6616.1 6674.4 6243.4 6309.0 6363.1 6417.0 6491.8 1732.2 1734.8 1790.0 1807.5 1814.0 849.7 852.3 862.7 865.8 890.0 17571.9 17655.6 18076.6 18206.8 18660.5 823.0 823.3 845.5 856.1 859.3 10047.8 10384.0 10590.0 10659.3 10686.1 556967.0 560778.0 563946.0 563950.0 570208.0 84979.2 86204.0 93019.5 99590.5 99890.0 947.7 982.2 984.5 986.9 989.6 16225.0 16254.0 16406.5 16479.8 16808.5 34398.8 39871.0 40014.9 40702.8 42049.8 56564.4 58052.0 59646.7 60862.3 60914.4 7268.7 7468.3 7469.9 7599.4 7687.3 11131.3 11308.7 11448.3 12005.6 12055.9 9731.6 9847.9 10131.3 10434.7 10575.6 10449.3 10466.5 10544.5 10588.7 10653.5 9914.3 10219.8 10513.6 10681.4 10715.9 7166.1 7251.5 7334.7 7432.8 7606.2 9364.6 9666.3 10446.0 10673.3 10706.3 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | [#3] mootools.html Cycles:180 Average:4473.72 Median:5403.96 stddev:2396.25 (44.3%) stddev-sans-first:2389.61 12:41:30 INFO - PROCESS | 2193 | Values: 1106.3 1123.5 1130.9 1141.3 1179.6 6102.8 6296.7 6503.0 6941.4 6963.4 6530.7 6772.6 6777.7 6887.7 6889.4 1800.8 1818.5 1823.1 1824.1 1828.5 1988.7 2013.3 2030.5 2032.9 2082.3 2099.9 2128.2 2130.1 2132.5 2144.3 1967.3 1997.9 2006.9 2012.6 2016.7 2059.4 2064.5 2085.3 2086.7 2087.5 6824.1 6971.0 6980.7 6986.7 6993.1 4120.1 4251.8 4253.2 4255.4 4256.2 2465.4 2660.2 2688.5 2700.1 2712.4 1059.5 1062.1 1102.2 1114.2 1130.6 8791.7 8826.3 8827.4 8850.3 8963.5 3527.1 3617.8 3693.5 3756.6 3757.5 7069.3 7145.7 7177.4 7187.1 7209.3 4114.3 4121.0 4147.2 4167.9 4251.7 3724.8 3757.8 3852.7 3859.2 3860.0 3089.9 3122.9 3183.0 3225.0 3226.8 867.4 896.0 932.1 939.4 947.3 620.2 622.3 632.4 637.5 643.9 4403.5 4515.5 4590.2 4678.6 4827.6 852.8 881.7 885.5 885.6 887.9 3148.3 3190.7 3305.5 3350.1 3390.8 7972.5 8072.0 8140.2 8195.0 8243.0 8069.7 8082.4 8103.3 8206.6 8213.1 6458.7 6478.0 6521.4 6605.4 6660.4 4670.6 4782.9 4847.9 4856.5 4998.4 7515.5 7553.1 7605.2 7705.0 7707.4 7690.2 7708.5 7745.6 7760.1 7827.8 5675.9 5755.7 5758.2 5772.7 5783.6 6453.1 6467.4 6515.4 6567.6 6577.3 5912.5 5923.1 5955.8 5970.3 6013.7 5527.4 5584.4 5589.1 5590.8 5601.9 5397.4 5410.5 5438.6 5453.0 5460.1 3962.5 4023.3 4055.5 4130.4 4171.4 4097.6 4130.4 4218.8 4225.7 4266.7 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | [#4] prototype.html Cycles:180 Average:4202.63 Median:4775.00 stddev:1230.23 (25.8%) stddev-sans-first:1198.64 12:41:30 INFO - PROCESS | 2193 | Values: 318.7 320.1 322.1 327.8 340.5 4821.2 4946.2 4955.8 4957.7 4975.3 4899.0 4904.7 4906.0 4928.8 4933.8 3632.5 3804.2 3807.3 3955.5 3969.6 3814.9 3815.5 3816.4 3821.7 3827.4 3794.2 3797.8 3800.3 3809.8 3810.2 3825.2 3825.4 3831.5 3840.9 3842.3 3278.2 3279.4 3313.3 3316.3 3339.9 4710.3 4734.8 4757.5 4788.4 4790.4 4295.3 4301.6 4304.9 4321.7 4321.8 4957.8 5074.5 5120.7 5145.3 5152.5 3596.3 3605.5 3618.0 3626.0 3626.7 5390.5 5398.9 5403.2 5404.8 5431.2 3526.7 3631.4 3636.0 3644.6 3661.8 3635.7 3646.6 3658.5 3662.3 3670.4 4240.3 4240.4 4247.3 4248.3 4258.2 5147.9 5163.2 5172.4 5177.8 5214.7 1209.7 1228.7 1232.0 1248.4 1252.2 812.7 820.5 839.8 844.2 847.7 4420.4 4428.0 4434.3 4465.3 4514.5 5280.9 5289.4 5301.7 5302.2 5303.8 4500.4 4506.4 4516.6 4534.4 4546.8 2686.7 2721.9 2729.7 2762.4 2788.4 4755.4 4775.7 4777.2 4780.9 4829.1 5227.9 5276.9 5277.5 5291.7 5305.3 4542.9 4732.6 4738.8 4774.3 4793.3 5119.4 5131.5 5158.8 5159.7 5170.4 5099.8 5109.3 5113.6 5120.5 5141.9 4631.8 4723.3 4766.8 4779.7 4799.2 3513.9 3521.6 3545.0 3558.7 3567.7 5092.2 5223.2 5234.9 5238.0 5242.0 4842.9 5022.6 5061.8 5067.7 5081.3 4935.0 5022.4 5028.5 5031.7 5046.8 4951.4 4974.4 4975.5 4996.1 5001.2 4848.6 5069.9 5075.8 5206.2 5242.0 4851.6 4919.2 4988.8 5011.5 5017.2 12:41:30 INFO - PROCESS | 2193 | 12:41:30 INFO - PROCESS | 2193 | [#5] yui.html Cycles:180 Average:14282.61 Median:2270.56 stddev:17569.45 (773.8%) stddev-sans-first:17588.86 12:41:30 INFO - PROCESS | 2193 | Values: 638.4 656.9 720.0 726.8 762.8 12828.3 13380.6 13437.0 13499.7 13539.0 12765.8 12797.9 12888.5 12950.8 12994.5 800.8 811.9 818.6 819.7 822.1 816.1 817.3 818.2 818.7 819.5 852.7 854.8 856.3 856.3 856.6 846.0 846.6 847.0 848.3 849.6 621.5 625.1 625.7 627.8 629.5 11602.8 11611.8 11709.6 11718.9 12124.8 10647.6 11153.2 11206.4 11672.2 11771.4 11733.5 11860.3 11957.9 11962.2 12573.1 4050.2 4062.7 4113.5 4114.6 4124.4 63753.4 64780.7 65356.0 65941.3 65950.0 9890.4 10003.2 10040.1 10127.8 10562.3 17627.1 17629.2 17679.5 17799.6 18042.0 6109.2 6140.8 6166.0 6204.3 6239.0 3402.2 3446.7 3449.5 3462.2 3466.5 2385.7 2419.6 2433.9 2436.0 2436.7 446.0 450.9 458.5 461.2 462.0 416.7 422.4 424.6 441.7 447.0 6646.9 6664.6 6780.6 6938.6 6949.7 539.6 554.1 558.2 574.6 586.9 3452.5 3553.5 3659.3 3786.3 3874.2 60666.7 60734.7 61450.0 61678.0 62851.7 35998.8 39193.6 47376.3 54743.0 54824.7 48677.0 49700.8 49900.8 50228.0 51767.5 8016.7 8535.7 8539.0 8539.5 8644.0 34066.7 35308.5 36053.3 36195.8 36646.8 43627.1 43936.8 46441.0 46679.5 47218.0 11176.7 11263.1 11442.9 11550.7 11691.2 12595.6 12656.7 12690.3 13085.8 13094.9 11223.8 11290.5 11522.0 11694.1 11842.2 11870.6 11921.8 12224.9 12319.1 12420.8 12104.5 12151.7 12217.5 12383.3 12926.4 10086.2 10213.2 10446.5 10510.8 10589.0 8560.7 8709.9 8835.6 9029.1 9191.6 12:41:30 INFO - PROCESS | 2193 | -------- Summary: end -------- 12:41:30 INFO - PROCESS | 2193 | 12:41:31 INFO - TEST-INFO | 2193: exit 0 12:41:31 INFO - TEST-OK | dromaeo_css | took 1119337ms 12:41:31 INFO - TEST-START | kraken 12:41:31 INFO - operating with platform_type : linux_ 12:41:31 INFO - Initialising browser for kraken test... 12:41:31 INFO - TEST-INFO | started process 2628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82UIp8/profile http://localhost:41052/getInfo.html) 12:41:31 INFO - PROCESS | 2628 | 1483648891979 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 12:41:35 INFO - PROCESS | 2628 | __metrics Screen width/height:1600/1200 12:41:35 INFO - PROCESS | 2628 | colorDepth:24 12:41:35 INFO - PROCESS | 2628 | Browser inner width/height: 1024/697 12:41:35 INFO - PROCESS | 2628 | __metrics 12:41:36 ERROR - PROCESS | 2628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 12:41:37 INFO - TEST-INFO | 2628: exit 0 12:41:37 INFO - Browser initialized. 12:41:37 INFO - Running cycle 1/1 for kraken test... 12:41:37 INFO - TEST-INFO | started process 2822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82UIp8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:49 INFO - PROCESS | 2822 | RSS: Main: 158363648 12:41:49 INFO - PROCESS | 2822 | 12:41:52 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41052/tests/kraken/driver.html?testName=audio-beat-detection) 12:41:53 INFO - PROCESS | 2822 | RSS: Main: 163880960 12:41:53 INFO - PROCESS | 2822 | 12:41:56 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41052/tests/kraken/driver.html?testName=audio-dft) 12:41:56 INFO - PROCESS | 2822 | RSS: Main: 163094528 12:41:56 INFO - PROCESS | 2822 | 12:41:59 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41052/tests/kraken/driver.html?testName=audio-fft) 12:42:00 INFO - PROCESS | 2822 | RSS: Main: 159404032 12:42:00 INFO - PROCESS | 2822 | 12:42:02 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41052/tests/kraken/driver.html?testName=audio-oscillator) 12:42:03 INFO - PROCESS | 2822 | RSS: Main: 159719424 12:42:03 INFO - PROCESS | 2822 | 12:42:05 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:42:05 INFO - PROCESS | 2822 | RSS: Main: 160247808 12:42:05 INFO - PROCESS | 2822 | 12:42:09 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41052/tests/kraken/driver.html?testName=imaging-darkroom) 12:42:09 INFO - PROCESS | 2822 | RSS: Main: 166035456 12:42:09 INFO - PROCESS | 2822 | 12:42:13 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41052/tests/kraken/driver.html?testName=imaging-desaturate) 12:42:13 INFO - PROCESS | 2822 | RSS: Main: 162279424 12:42:13 INFO - PROCESS | 2822 | 12:42:16 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41052/tests/kraken/driver.html?testName=json-parse-financial) 12:42:17 INFO - PROCESS | 2822 | RSS: Main: 163762176 12:42:17 INFO - PROCESS | 2822 | 12:42:19 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:42:19 INFO - PROCESS | 2822 | RSS: Main: 163610624 12:42:19 INFO - PROCESS | 2822 | 12:42:21 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:42:22 INFO - PROCESS | 2822 | RSS: Main: 163577856 12:42:22 INFO - PROCESS | 2822 | 12:42:24 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:42:25 INFO - PROCESS | 2822 | RSS: Main: 164331520 12:42:25 INFO - PROCESS | 2822 | 12:42:27 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:42:28 INFO - PROCESS | 2822 | RSS: Main: 164581376 12:42:28 INFO - PROCESS | 2822 | 12:42:31 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:42:32 INFO - PROCESS | 2822 | RSS: Main: 164261888 12:42:32 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | Cycle 1(1): loaded http://localhost:41052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41052/tests/kraken/driver.html?testName=ai-astar) 12:42:34 INFO - PROCESS | 2822 | RSS: Main: 165920768 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | __start_tp_report 12:42:34 INFO - PROCESS | 2822 | _x_x_mozilla_page_load 12:42:34 INFO - PROCESS | 2822 | _x_x_mozilla_page_load_details 12:42:34 INFO - PROCESS | 2822 | |i|pagename|runs| 12:42:34 INFO - PROCESS | 2822 | |0;ai-astar;109;118;118;115;115;117;116;116;118;120 12:42:34 INFO - PROCESS | 2822 | |1;audio-beat-detection;151;127;125;180;126;129;126;127;150;134 12:42:34 INFO - PROCESS | 2822 | |2;audio-dft;166;167;177;164;162;162;162;163;163;164 12:42:34 INFO - PROCESS | 2822 | |3;audio-fft;77;78;78;102;78;78;77;76;94;87 12:42:34 INFO - PROCESS | 2822 | |4;audio-oscillator;85;85;105;89;87;87;100;86;87;101 12:42:34 INFO - PROCESS | 2822 | |5;imaging-gaussian-blur;118;118;118;117;118;120;117;117;118;119 12:42:34 INFO - PROCESS | 2822 | |6;imaging-darkroom;151;150;151;152;151;151;151;151;151;152 12:42:34 INFO - PROCESS | 2822 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;98;95 12:42:34 INFO - PROCESS | 2822 | |8;json-parse-financial;68;69;67;69;69;69;71;69;69;69 12:42:34 INFO - PROCESS | 2822 | |9;json-stringify-tinderbox;72;67;67;68;71;71;68;68;71;68 12:42:34 INFO - PROCESS | 2822 | |10;stanford-crypto-aes;85;86;86;88;89;86;88;85;90;86 12:42:34 INFO - PROCESS | 2822 | |11;stanford-crypto-ccm;139;152;139;140;135;147;132;135;196;144 12:42:34 INFO - PROCESS | 2822 | |12;stanford-crypto-pbkdf2;181;175;178;181;183;180;182;179;180;178 12:42:34 INFO - PROCESS | 2822 | |13;stanford-crypto-sha256-iterative;73;69;69;75;70;73;69;70;68;69 12:42:34 INFO - PROCESS | 2822 | __end_tp_report 12:42:34 INFO - PROCESS | 2822 | __start_cc_report 12:42:34 INFO - PROCESS | 2822 | _x_x_mozilla_cycle_collect,814 12:42:34 INFO - PROCESS | 2822 | __end_cc_report 12:42:34 INFO - PROCESS | 2822 | __startTimestamp1483648954471__endTimestamp 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | ------- Summary: start ------- 12:42:34 INFO - PROCESS | 2822 | Number of tests: 14 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#0] ai-astar Cycles:10 Average:116.20 Median:117.50 stddev:2.97 (2.5%) stddev-sans-first:1.66 12:42:34 INFO - PROCESS | 2822 | Values: 109.0 118.0 118.0 115.0 115.0 117.0 116.0 116.0 118.0 120.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:131.50 stddev:17.86 (13.6%) stddev-sans-first:18.26 12:42:34 INFO - PROCESS | 2822 | Values: 151.0 127.0 125.0 180.0 126.0 129.0 126.0 127.0 150.0 134.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.55 (2.8%) stddev-sans-first:4.81 12:42:34 INFO - PROCESS | 2822 | Values: 166.0 167.0 177.0 164.0 162.0 162.0 162.0 163.0 163.0 164.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#3] audio-fft Cycles:10 Average:82.50 Median:78.00 stddev:8.92 (11.4%) stddev-sans-first:9.24 12:42:34 INFO - PROCESS | 2822 | Values: 77.0 78.0 78.0 102.0 78.0 78.0 77.0 76.0 94.0 87.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:86.50 stddev:7.64 (8.8%) stddev-sans-first:7.77 12:42:34 INFO - PROCESS | 2822 | Values: 85.0 85.0 105.0 89.0 87.0 87.0 100.0 86.0 87.0 101.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 12:42:34 INFO - PROCESS | 2822 | Values: 118.0 118.0 118.0 117.0 118.0 120.0 117.0 117.0 118.0 119.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:42:34 INFO - PROCESS | 2822 | Values: 151.0 150.0 151.0 152.0 151.0 151.0 151.0 151.0 151.0 152.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 12:42:34 INFO - PROCESS | 2822 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 98.0 95.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 12:42:34 INFO - PROCESS | 2822 | Values: 68.0 69.0 67.0 69.0 69.0 69.0 71.0 69.0 69.0 69.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:1.91 (2.8%) stddev-sans-first:1.72 12:42:34 INFO - PROCESS | 2822 | Values: 72.0 67.0 67.0 68.0 71.0 71.0 68.0 68.0 71.0 68.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:1.73 (2.0%) stddev-sans-first:1.69 12:42:34 INFO - PROCESS | 2822 | Values: 85.0 86.0 86.0 88.0 89.0 86.0 88.0 85.0 90.0 86.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:142.00 stddev:18.60 (13.1%) stddev-sans-first:19.56 12:42:34 INFO - PROCESS | 2822 | Values: 139.0 152.0 139.0 140.0 135.0 147.0 132.0 135.0 196.0 144.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:180.50 stddev:2.31 (1.3%) stddev-sans-first:2.40 12:42:34 INFO - PROCESS | 2822 | Values: 181.0 175.0 178.0 181.0 183.0 180.0 182.0 179.0 180.0 178.0 12:42:34 INFO - PROCESS | 2822 | 12:42:34 INFO - PROCESS | 2822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:2.32 (3.3%) stddev-sans-first:2.28 12:42:34 INFO - PROCESS | 2822 | Values: 73.0 69.0 69.0 75.0 70.0 73.0 69.0 70.0 68.0 69.0 12:42:34 INFO - PROCESS | 2822 | -------- Summary: end -------- 12:42:34 INFO - PROCESS | 2822 | 12:42:35 INFO - TEST-INFO | 2822: exit 0 12:42:35 INFO - TEST-OK | kraken | took 64171ms 12:42:35 INFO - SUITE-END | took 1183s 12:42:36 INFO - Completed test suite (00:19:43) 12:42:36 INFO - javascript benchmark 12:42:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6222.720519852811, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.7006894207148, 2604.661394018778, 2606.934826629334, 2637.5120602688503, 2657.083306259341, 4761.2143996240575, 4846.4668886422505, 4877.536634019772, 4894.216925291954, 4917.606591472673, 4770.499097594755, 4807.471178170398, 4846.0, 4850.393700787402, 4883.9755801220945, 4371.956280437194, 4420.690551661385, 4446.288593824988, 4520.638348932078, 4556.339330797033, 4054.2499637567, 4485.955140448603, 4489.147062058215, 4501.369808226835, 4501.482329532113, 4337.739735615842, 4448.733076015449, 4472.463304403493, 4490.640748740093, 4577.473590537081, 4341.1100724351745, 4385.583369579885, 4433.202023635744, 4437.822487100512, 4520.434945631796, 4397.2304846651705, 4421.93873470368, 4440.777961101932, 4445.0, 4457.041736026737, 4777.211760059586, 4807.375041244651, 4838.661293709441, 4845.200541910581, 4865.732384718839, 4991.550760431543, 5028.622853286018, 5059.367579052619, 5068.518490743373, 5109.770060347293, 5172.250023746573, 5173.870653233662, 5174.818881339173, 5182.637215394924, 5240.973795131038, 4830.468648448667, 4836.733979631119, 4860.80556777732, 4864.027194561102, 4886.413630364379, 5213.661112027706, 5259.710715910585, 5263.105272103751, 5273.1299335609965, 5292.7353632319, 4964.404271487445, 4993.176125939252, 5019.47295533971, 5025.14572522672, 5055.8988820223385, 5091.949080509147, 5095.617828662865, 5103.8468845934685, 5121.692698438105, 5129.281900533928, 5020.146575082172, 5053.46938571452, 5060.645754797129, 5067.366579177603, 5073.315102461194, 5058.215976523645, 5062.215356619729, 5065.265536497261, 5071.873203169876, 5094.643374963791, 4293.720908140961, 4315.395844581761, 4327.307630779061, 4329.480462344539, 4336.869893903188, 3781.810909454516, 3804.2201348723447, 3835.7890316032326, 3902.941455878164, 3907.843686252575, 4440.289553671461, 4441.489228738672, 4446.221911165598, 4460.219461594273, 4487.753173575485, 5044.419891712427, 5072.82245121419, 5197.116490196676, 5205.063088644005, 5214.478552144755, 4385.210662080793, 4407.2507673695545, 4421.734695918255, 4443.066955939289, 4482.955170448319, 4644.0944015916575, 4646.79089440976, 4653.534646535387, 4662.813487460531, 4696.694714843524, 4778.617710583145, 4785.952140478551, 4793.904121917542, 4800.807967681254, 4840.201366774513, 5016.347874776256, 5065.696058236517, 5087.109755792795, 5118.155504341742, 5130.769115389891, 4763.976180119077, 4772.832950846704, 4785.808567657394, 4813.350197723263, 4813.989062296957, 5079.873003174803, 5081.796728130981, 5093.286939828353, 5099.3370861787735, 5101.770420331169, 4972.975135124301, 5013.147764879906, 5113.079645663816, 5149.588032957279, 5187.610929180402, 4983.526564976321, 5007.273945277987, 5019.824306149268, 5025.095482813129, 5033.219850923113, 4921.557059864629, 4967.304577359245, 4993.375828021497, 5004.824831130893, 5023.8492845214705, 4885.1206782779445, 4953.554180123806, 4969.453360130455, 4984.626153038609, 5004.649674522749, 4933.407991041098, 4951.306817045688, 4963.205887058053, 4974.701517908937, 5003.499650034967, 4870.0, 4878.512148785093, 4894.951050489592, 4900.166971614763, 4909.926351104665], "value": 4709.067004318985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.8047541934066, 519.5661622545177, 527.1854984049643, 537.4705914674046, 550.859530819641, 38976.415353769684, 41164.38253426201, 41272.58727412725, 41288.58711412885, 44611.33083003757, 40874.38688419668, 41258.381124283085, 41742.58257417425, 41812.0, 41910.58089419105, 7785.961070194655, 7913.0899946506315, 7952.125266220711, 7971.840563188733, 9581.377210481296, 9473.384230025027, 9716.465594392306, 9727.90272097277, 9730.805383892319, 9747.074027967366, 9748.610055597768, 9760.4631745254, 9765.658201962933, 9829.410235385863, 9838.754031149243, 9663.758406039835, 9714.805703885882, 9723.319367644268, 9731.075547823017, 9771.951140244253, 9736.853947190797, 9742.269329800223, 9784.657536986171, 9795.510224488748, 9800.90199098007, 33443.83278083594, 33601.0, 33805.49291760626, 33922.91156326546, 33929.0, 3589.6230895756094, 3628.4013137832226, 3666.120131168527, 3669.504616876714, 3673.687736542397, 25363.87318063398, 25950.0, 25981.610275845876, 26056.60915086275, 26335.34161645974, 3395.2190996070794, 3412.6246112927556, 3418.0, 3434.7767395119236, 3458.3083383323437, 238216.0, 241306.0, 242608.0, 243570.0, 244156.0, 45912.0, 46266.30600540995, 46432.7678361606, 46528.06943861172, 46633.53366466292, 48623.27065094026, 48679.0, 48738.512614874104, 48752.26871596929, 48768.51231487711, 12325.137240393266, 12590.307533085768, 12624.116311858083, 12640.620781376574, 12646.114771965875, 8399.70601028961, 8580.871286930576, 9018.819623607491, 9222.40054396462, 9531.428114313163, 15632.609184770245, 15637.3745050199, 15753.606159846095, 15820.367185312689, 15902.363905443885, 6499.577527460794, 6500.9349906501275, 6629.635370054693, 6715.4291885190305, 6798.694058767268, 776.8679324514846, 802.7070119406375, 805.472415567804, 806.7055524733547, 812.4028838803474, 26462.20613381563, 27031.86484067567, 27900.581491277648, 28005.0, 28143.71856281452, 928.6563971330515, 955.1308309438516, 958.2334132693817, 965.4979410706393, 967.2358836519212, 14337.856621433652, 14895.180765057808, 14961.551153465414, 15085.849141508445, 15209.239538023054, 352185.0, 355251.0, 356992.0, 357188.0, 358036.0, 50460.747696261285, 50977.490225098016, 51079.48920510821, 51144.488555114716, 51242.48757512377, 1201.7596480703894, 1222.8165775133623, 1229.4037391864938, 1241.5468354050888, 1243.881831226032, 25805.0, 26327.21018369452, 26886.865565672048, 26983.325416864736, 27027.0, 42684.57315426806, 42973.785131074146, 43020.35469468023, 43077.78461107674, 43182.56817431786, 291217.0, 292697.48583940894, 292828.0, 293055.0, 295021.0, 22993.195238167253, 23475.178368757013, 23498.0, 24872.751272487043, 25662.486750264517, 35453.290934181685, 35594.46608300929, 36171.0, 36207.456888146175, 36356.272874541835, 30532.389352213275, 30691.0, 31063.0, 31438.528422074145, 31618.051458456284, 26820.0, 27213.727862721913, 27390.0, 27445.176644700692, 27492.0, 30368.84815575908, 30455.543166852072, 30703.69296307098, 30908.845455772578, 30927.0, 27339.179824605293, 28518.714812851606, 28771.856140719163, 28782.280442989093, 28844.0, 22027.559448811255, 22146.557068858212, 22163.77836221617, 22221.777782222616, 22316.77683223147], "value": 16895.431013865727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.62261559286134, 367.3332900785075, 368.08778396231577, 382.2660491855637, 385.8726620215329, 16926.830731692695, 18292.176852041655, 18754.906225468854, 18854.62290754186, 18977.715334269997, 17406.564835879108, 17804.910975445106, 17858.64282714345, 18040.458786236402, 18252.17865196066, 5022.19644856823, 5230.633855630107, 5234.136367499358, 5237.528622423981, 5243.318368612075, 4948.505149485059, 5054.671446355975, 5093.108705976458, 5093.974530127362, 5118.360204974379, 5057.6965382077005, 5071.644984851062, 5078.162103252977, 5081.517255860687, 5097.362829646294, 4921.311016457699, 5081.314022606938, 5144.897102057976, 5162.354705661793, 5176.0683077046115, 4575.039241759235, 4575.565321294472, 4582.977085114587, 4584.564466375722, 4589.977050114761, 18126.365577204735, 21441.571168576542, 21506.247281345077, 21510.0, 21644.458888527755, 2295.5753185660706, 2352.8235382346393, 2397.7961873240797, 2404.843685160459, 2410.2166795791436, 13415.597532074053, 13490.595282141552, 13617.319134043259, 13672.65818354549, 14103.929480352532, 1730.3338214787273, 1738.75657407963, 1741.9041952692596, 1759.1468137953082, 1817.164104511926, 70931.0, 71602.0, 72758.0, 72791.0, 73106.0, 9587.0, 9667.371620844622, 9753.609855605697, 9758.343150745954, 9951.950240248898, 12973.41619627119, 13084.607461776162, 13086.345682715826, 13098.410571524304, 13189.0, 6703.195616526048, 6907.481938854606, 6964.129483814523, 7044.22513523512, 7107.502474826816, 6411.839704007437, 6475.579087359307, 6611.173603299588, 6616.106825578581, 6674.432673222734, 6243.406876346739, 6308.968455157787, 6363.109164716943, 6416.967915160394, 6491.837704057436, 1732.2378153612622, 1734.8178441263738, 1790.0333819737195, 1807.484866812952, 1813.9818601814077, 849.7493239494364, 852.2755657691037, 862.7109918177356, 865.7965378136133, 889.9955500222458, 17571.912140439472, 17655.646887062187, 18076.638467230845, 18206.81793182051, 18660.533486662942, 822.9877250981326, 823.300194834398, 845.471580262336, 856.1096459681986, 859.3254295378098, 10047.799044019224, 10384.0, 10590.0, 10659.307145035704, 10686.091682206945, 556967.0, 560778.0, 563946.0, 563950.0, 570208.0, 84979.15020849713, 86204.0, 93019.53490232506, 99590.50204749075, 99890.0, 947.6541062512272, 982.1896935028487, 984.5175863826817, 986.8667729856378, 989.6437282578122, 16225.0, 16254.0, 16406.507804765875, 16479.83520164783, 16808.495745127664, 34398.82800585981, 39871.0, 40014.932802389245, 40702.79648601738, 42049.78975105105, 56564.43435565592, 58052.0, 59646.70176649089, 60862.3482591046, 60914.390856090875, 7268.67290971897, 7468.253174682705, 7469.925300746923, 7599.430042746705, 7687.308142267223, 11131.276467029616, 11308.717282068013, 11448.313101213955, 12005.63983080509, 12055.879441205476, 9731.56207970629, 9847.852282215916, 10131.290809643255, 10434.68695939123, 10575.62985295511, 10449.268551201647, 10466.529006194587, 10544.472776360997, 10588.735281618021, 10653.467326633483, 9914.30599858003, 10219.795604088025, 10513.579456821948, 10681.359118452918, 10715.892841071489, 7166.140063192451, 7251.456140789356, 7334.669939852826, 7432.814179645552, 7606.163322034461, 9364.625414983324, 9666.323357365198, 10446.0, 10673.306235094695, 10706.304090234109], "value": 8590.66376414436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1106.314085267134, 1123.5449642894625, 1130.9321440713563, 1141.3437273567702, 1179.5635614822518, 6102.847428814282, 6296.6536840473755, 6503.0, 6941.444684425246, 6963.408110310617, 6530.738770449188, 6772.627505487197, 6777.7288908443725, 6887.7244910203535, 6889.448844092473, 1800.79290881549, 1818.481732706179, 1823.088455772114, 1824.1061879678928, 1828.5097645419007, 1988.7116368126613, 2013.3154727392684, 2030.46192758919, 2032.928847490338, 2082.2607974169105, 2099.937001889946, 2128.17001369466, 2130.147940823675, 2132.509522809755, 2144.345974477784, 1967.3212741604123, 1997.900104994759, 2006.8695534790193, 2012.64778663734, 2016.747906511686, 2059.4130672758342, 2064.5457999240143, 2085.270155445582, 2086.69742887282, 2087.5303056812095, 6824.1128653275255, 6971.0, 6980.720771169147, 6986.685599148, 6993.05593744843, 4120.134771697947, 4251.829926802924, 4253.191893540248, 4255.361695745632, 4256.212600668886, 2465.359006658282, 2660.188642464048, 2688.4623075385, 2700.0819721294656, 2712.4303896181827, 1059.539100491281, 1062.1078294232882, 1102.2449622008949, 1114.1866437500669, 1130.5760339872547, 8791.736247912573, 8826.293896488265, 8827.382083254175, 8850.336224783166, 8963.507007114606, 3527.1182204448887, 3617.782933024027, 3693.4644476550748, 3756.6431189037, 3757.511523501982, 7069.257727938492, 7145.749898753519, 7177.4258059355125, 7187.065681461481, 7209.279072092749, 4114.280000999813, 4120.958790412117, 4147.212029714345, 4167.937480937789, 4251.723637963522, 3724.795136267477, 3757.774533527997, 3852.6917846572205, 3859.2281543691374, 3860.0, 3089.891853785107, 3122.87508499662, 3182.9681703182673, 3224.967750322514, 3226.774125811218, 867.444835305405, 895.9507227102441, 932.137772560379, 939.3565407695751, 947.313197931508, 620.2092332276294, 622.2626187967273, 632.3644737039338, 637.4963778614936, 643.8937575300023, 4403.471583410012, 4515.503294637587, 4590.173768721662, 4678.555537223959, 4827.589654879304, 852.7953291210065, 881.7266647339345, 885.4731434796286, 885.5749240364661, 887.9112088791069, 3148.338848841769, 3190.7287880529952, 3305.471124620049, 3350.0787283497234, 3390.830458477116, 7972.481788683717, 8071.959640201879, 8140.226678465537, 8194.959025204955, 8243.0, 8069.7175598853755, 8082.393820463371, 8103.270705636521, 8206.58967051645, 8213.096559378464, 6458.709358078898, 6477.967610161919, 6521.413072823469, 6605.438537724252, 6660.400563949171, 4670.649701272486, 4782.880427989328, 4847.903041939071, 4856.470211883246, 4998.400191976986, 7515.473916825769, 7553.093628764584, 7605.239476052572, 7704.961475192588, 7707.421943354158, 7690.154083050972, 7708.537487750753, 7745.612719363897, 7760.107587627269, 7827.804304892423, 5675.943240567542, 5755.7409916553015, 5758.193852860519, 5772.682502462237, 5783.595148339576, 6453.09656648079, 6467.417932386108, 6515.413612774683, 6567.605943643397, 6577.309382514767, 5912.46787789101, 5923.08192230205, 5955.821325360246, 5970.283565972111, 6013.7293821779, 5527.44725527444, 5584.357798853184, 5589.133684278943, 5590.776368945197, 5601.915971260353, 5397.379301380392, 5410.539154428204, 5438.564914806727, 5453.0, 5460.126379779216, 3962.54430740457, 4023.2959232134845, 4055.53361363447, 4130.401091841726, 4171.353440216772, 4097.623378440438, 4130.380442933584, 4218.810153543037, 4225.683073769418, 4266.743995360288], "value": 3652.3116606231943, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6701763674597, 320.1260558674819, 322.13185465171375, 327.76892290934893, 340.48416648777106, 4821.228603423453, 4946.230111137761, 4955.776990035448, 4957.652964292501, 4975.328330675362, 4898.951010489894, 4904.730239836807, 4905.950940490594, 4928.802847886089, 4933.7779799909, 3632.4551317302353, 3804.2201348723584, 3807.2956503047026, 3955.545112312092, 3969.6427321541055, 3814.8855534334016, 3815.465834783133, 3816.370298900678, 3821.700621788605, 3827.3876179811236, 3794.1652836376093, 3797.810109494528, 3800.258949504848, 3809.847606095767, 3810.1808111256073, 3825.158465137665, 3825.387937929932, 3831.501904752364, 3840.884773456773, 3842.250761101572, 3278.2132288250887, 3279.44249477587, 3313.3042061167184, 3316.2538428853554, 3339.899803005889, 4710.317004034396, 4734.7689600703725, 4757.500462451428, 4788.449328327252, 4790.4251489821445, 4295.312749960022, 4301.634361079312, 4304.913901721948, 4321.65426765858, 4321.82712691492, 4957.752112394366, 5074.517920797555, 5120.692758434506, 5145.33110695611, 5152.4847515248175, 3596.2737885814695, 3605.513255710498, 3617.963820361815, 3625.963740362615, 3626.691731202851, 5390.5418039466695, 5398.946010539884, 5403.2165336026055, 5404.7838086476495, 5431.158170483582, 3526.717862570988, 3631.4008188649104, 3636.0, 3644.562652481666, 3661.798601076913, 3635.7093231902295, 3646.6353364663323, 3658.487811706363, 3662.2675464907124, 3670.3576874046935, 4240.300350442204, 4240.448741663626, 4247.299195632686, 4248.34150706641, 4258.190943720683, 5147.871303217375, 5163.225516172529, 5172.379314482287, 5177.8187763428095, 5214.6610470320065, 1209.7036226124656, 1228.7112528555783, 1231.9876801231874, 1248.4194849395076, 1252.2173641474078, 812.6911773526023, 820.4953953318666, 839.8278352937633, 844.2401838345538, 847.6609356257546, 4420.359047938031, 4428.0, 4434.268345722984, 4465.330200469955, 4514.480834703985, 5280.867978300496, 5289.3652761668845, 5301.734913254322, 5302.1781623848365, 5303.761330740126, 4500.369948207253, 4506.414166158444, 4516.638668906479, 4534.36518887356, 4546.772661366985, 2686.6641669791275, 2721.931951701223, 2729.6587926509187, 2762.4198918226994, 2788.372616161388, 4755.429348478136, 4775.6657034007985, 4777.187878060738, 4780.852595377084, 4829.064312585232, 5227.86998271369, 5276.947230527722, 5277.472252774769, 5291.656042357235, 5305.283786688748, 4542.909701671641, 4732.550407711331, 4738.838984448832, 4774.3315935769715, 4793.304970779218, 5119.360079990001, 5131.461196574455, 5158.845234642967, 5159.690418574897, 5170.405403378509, 5099.847004589868, 5109.335786347751, 5113.565346945551, 5120.487951204998, 5141.897162056813, 4631.768411579475, 4723.291506274087, 4766.785494652819, 4779.737114458738, 4799.208130658402, 3513.9297214056087, 3521.612622611562, 3545.0, 3558.679718825318, 3567.714582833315, 5092.206306301829, 5223.190405487156, 5234.921476177784, 5238.0, 5241.9737901310245, 4842.854714358575, 5022.573081287986, 5061.848144555669, 5067.746612669278, 5081.263216833465, 4934.950650493593, 5022.447530771539, 5028.522290382408, 5031.6729412588065, 5046.84859454217, 4951.430585482715, 4974.427940786856, 4975.527324904128, 4996.100701873697, 5001.24981252815, 4848.587870031087, 5069.923951140662, 5075.771590278372, 5206.245094461357, 5242.0, 4851.56335929768, 4919.2129259318335, 4988.80940010393, 5011.498850114959, 5017.1721665924715], "value": 3815.170537114957, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.3903372279474, 656.9343065693434, 719.9748008819693, 726.7964969808453, 762.8283636181858, 12828.294443805598, 13380.59858204253, 13437.0, 13499.66250843728, 13539.0, 12765.80851287229, 12797.936010319936, 12888.548900788473, 12950.805737913939, 12994.54519091832, 800.7877912353216, 811.9106898241189, 818.607068607069, 819.7008092046419, 822.0587427395628, 816.1145157504086, 817.3134566963749, 818.1859050245015, 818.7134502923959, 819.5451524403953, 852.6845067325098, 854.7521218846558, 856.2764464027917, 856.3021137772695, 856.648774002656, 845.957702114898, 846.5851732651018, 846.9534175620338, 848.2789628815519, 849.6049337058266, 621.4655396359127, 625.0530446373748, 625.6902833097646, 627.802242293676, 629.468099455959, 11602.825957610643, 11611.825822612667, 11709.648710538697, 11718.941405293004, 12124.757504849942, 10647.627333043307, 11153.219274650777, 11206.439678016066, 11672.1829471937, 11771.352575608338, 11733.471993760217, 11860.288382697066, 11957.94021029898, 11962.222455540363, 12573.05702072339, 4050.18996200761, 4062.709205543519, 4113.526944401402, 4114.567970363129, 4124.443200167969, 63753.362466375205, 64780.67609661969, 65356.0, 65941.340586594, 65950.0, 9890.406575605486, 10003.199744020607, 10040.146587539995, 10127.848082278771, 10562.260641755158, 17627.118644067745, 17629.206685699173, 17679.469615911545, 17799.644007120045, 18042.0, 6109.20580324555, 6140.846478838065, 6165.969170154211, 6204.286507051746, 6238.968805156036, 3402.234497238151, 3446.655334466533, 3449.464643487035, 3462.1690794209208, 3466.4800279957703, 2385.6540801583674, 2419.6491508731137, 2433.9026438942597, 2436.0377650827822, 2436.707595088565, 445.97993090311013, 450.9233430316854, 458.52084571622737, 461.15608436561683, 461.97690115494765, 416.6812388522782, 422.41917363625015, 424.5711831050661, 441.68860953028036, 446.98882527937064, 6646.86706265872, 6664.600123992576, 6780.627065511444, 6938.618375989268, 6949.652517374111, 539.6095297830648, 554.1272495819021, 558.1516095534846, 574.6092656993201, 586.8708884045503, 3452.5166476693284, 3553.502509648651, 3659.304732100892, 3786.280606684721, 3874.244522318177, 60666.696666516385, 60734.69632651897, 61450.0, 61678.0, 62851.68574157191, 35998.820005899805, 39193.608063919564, 47376.28935565969, 54743.0, 54824.72587637116, 48677.0, 49700.751496243014, 49900.75049624729, 50228.0, 51767.48232517777, 8016.679332826621, 8535.743927682179, 8538.957305213682, 8539.487630742175, 8644.0, 34066.65933340734, 35308.47037294391, 36053.27893442169, 36195.819020904724, 36646.816765916, 43627.12745745131, 43936.780316098215, 46441.0, 46679.53320466752, 47218.0, 11176.664700059011, 11263.096335504131, 11442.942785286354, 11550.711232219262, 11691.181617286707, 12595.622131336075, 12656.74686506283, 12690.302033388252, 13085.803712944124, 13094.869051309364, 11223.775524489627, 11290.548378064785, 11522.0, 11694.122940779645, 11842.1710480269, 11870.58452954177, 11921.761564768483, 12224.87775122273, 12319.076069294659, 12420.813687794509, 12104.515819367127, 12151.696207594881, 12217.45021474018, 12383.257004579755, 12926.35368231566, 10086.193104551472, 10213.182945364502, 10446.52990615409, 10510.789784204426, 10589.0, 8560.657573697232, 8709.869351959853, 8835.558222089, 9029.142231487998, 9191.586378612845], "value": 6095.585351633334, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 118.0, 115.0, 115.0, 117.0, 116.0, 116.0, 118.0, 120.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 125.0, 180.0, 126.0, 129.0, 126.0, 127.0, 150.0, 134.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 177.0, 164.0, 162.0, 162.0, 162.0, 163.0, 163.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 102.0, 78.0, 78.0, 77.0, 76.0, 94.0, 87.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 89.0, 87.0, 87.0, 100.0, 86.0, 87.0, 101.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 120.0, 117.0, 117.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 152.0, 151.0, 151.0, 151.0, 151.0, 151.0, 152.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 98.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 69.0, 69.0, 69.0, 71.0, 69.0, 69.0, 69.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 67.0, 68.0, 71.0, 71.0, 68.0, 68.0, 71.0, 68.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 88.0, 89.0, 86.0, 88.0, 85.0, 90.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 152.0, 139.0, 140.0, 135.0, 147.0, 132.0, 135.0, 196.0, 144.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 175.0, 178.0, 181.0, 183.0, 180.0, 182.0, 179.0, 180.0, 178.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 69.0, 75.0, 70.0, 73.0, 69.0, 70.0, 68.0, 69.0], "value": 70.5, "unit": "score"}]}]} 12:42:36 INFO - Return code: 0 12:42:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:42:36 ERROR - # TBPL SUCCESS # 12:42:36 INFO - Running post-action listener: _resource_record_post_action 12:42:36 INFO - [mozharness: 2017-01-05 20:42:36.303346Z] Finished run-tests step (success) 12:42:36 INFO - Running post-run listener: _resource_record_post_run 12:42:36 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 12288; Write bytes: 406515712; Read time: 100; Write time: 237152 12:42:36 INFO - TinderboxPrint: CPU usage
13.5% 12:42:36 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 100 12:42:36 INFO - TinderboxPrint: I/O write bytes / time
406,515,712 / 237,152 12:42:36 INFO - TinderboxPrint: CPU idle
8,280.9 (86.5%) 12:42:36 INFO - TinderboxPrint: CPU user
1,234.8 (12.9%) 12:42:36 INFO - TinderboxPrint: Swap in / out
0 / 0 12:42:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99446784; Read time: 0; Write time: 79652 12:42:36 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 4096; Write bytes: 295223296; Read time: 80; Write time: 151052 12:42:36 INFO - Running post-run listener: _upload_blobber_files 12:42:36 INFO - Blob upload gear active. 12:42:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:42:36 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 12:42:36 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:42:36 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:42:37 INFO - (blobuploader) - INFO - Open directory for files ... 12:42:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:42:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:42:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:38 INFO - (blobuploader) - INFO - Done attempting. 12:42:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:42:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:39 INFO - (blobuploader) - INFO - Done attempting. 12:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:39 INFO - (blobuploader) - INFO - Done attempting. 12:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:42:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:43 INFO - (blobuploader) - INFO - Done attempting. 12:42:43 INFO - (blobuploader) - INFO - Iteration through files over. 12:42:43 INFO - Return code: 0 12:42:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:42:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:42:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/541a807c5b84a10c24b266a975f11a89f6b22f0883fb62679fd27b46280856f40115244bbbec5e85e5fa7076f9ae166411563421cf91229b2b3084fd910b2174", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/504f5da94f8f42a08766d1c72340287a42c75c959509f3e4afa8b81353086e4b9890e83234030d068c57b3b172d306e7775e0095a743390fff5718dbb92f5cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9bd07c086999dbaf8cdad847c8e88b37933316924b33e818148f7a7f4e30ad9c9a51b8ba4b8ff3b80170f3faf4d6bdf76aed38aadc3381beee6603c820bd6f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bf297e9683081911bd7b55d80d76fbb9a9dedb12b85cc6628451cd830ebb77d776c189bde5309706fe6db22d0477fc1b4470e43c279411c130a9b006d4f7d2dd"} 12:42:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:42:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:42:43 INFO - Contents: 12:42:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/541a807c5b84a10c24b266a975f11a89f6b22f0883fb62679fd27b46280856f40115244bbbec5e85e5fa7076f9ae166411563421cf91229b2b3084fd910b2174", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/504f5da94f8f42a08766d1c72340287a42c75c959509f3e4afa8b81353086e4b9890e83234030d068c57b3b172d306e7775e0095a743390fff5718dbb92f5cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9bd07c086999dbaf8cdad847c8e88b37933316924b33e818148f7a7f4e30ad9c9a51b8ba4b8ff3b80170f3faf4d6bdf76aed38aadc3381beee6603c820bd6f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bf297e9683081911bd7b55d80d76fbb9a9dedb12b85cc6628451cd830ebb77d776c189bde5309706fe6db22d0477fc1b4470e43c279411c130a9b006d4f7d2dd"} 12:42:43 INFO - Running post-run listener: copy_logs_to_upload_dir 12:42:43 INFO - Copying logs to upload dir... 12:42:43 INFO - mkdir: /builds/slave/test/build/upload/logs 12:42:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.577002 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-05 12:42:43.579961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 12:42:43.583658) ========= 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=00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/541a807c5b84a10c24b266a975f11a89f6b22f0883fb62679fd27b46280856f40115244bbbec5e85e5fa7076f9ae166411563421cf91229b2b3084fd910b2174", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/504f5da94f8f42a08766d1c72340287a42c75c959509f3e4afa8b81353086e4b9890e83234030d068c57b3b172d306e7775e0095a743390fff5718dbb92f5cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9bd07c086999dbaf8cdad847c8e88b37933316924b33e818148f7a7f4e30ad9c9a51b8ba4b8ff3b80170f3faf4d6bdf76aed38aadc3381beee6603c820bd6f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bf297e9683081911bd7b55d80d76fbb9a9dedb12b85cc6628451cd830ebb77d776c189bde5309706fe6db22d0477fc1b4470e43c279411c130a9b006d4f7d2dd"} build_url:https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/fNXp-SB-RRykgRt2hGbRIA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/541a807c5b84a10c24b266a975f11a89f6b22f0883fb62679fd27b46280856f40115244bbbec5e85e5fa7076f9ae166411563421cf91229b2b3084fd910b2174", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/504f5da94f8f42a08766d1c72340287a42c75c959509f3e4afa8b81353086e4b9890e83234030d068c57b3b172d306e7775e0095a743390fff5718dbb92f5cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9bd07c086999dbaf8cdad847c8e88b37933316924b33e818148f7a7f4e30ad9c9a51b8ba4b8ff3b80170f3faf4d6bdf76aed38aadc3381beee6603c820bd6f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bf297e9683081911bd7b55d80d76fbb9a9dedb12b85cc6628451cd830ebb77d776c189bde5309706fe6db22d0477fc1b4470e43c279411c130a9b006d4f7d2dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 12:42:43.609292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 12:42:43.609657) ========= 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=00204705a9daa57ed339a427000001b9-1483646558.977180-1012624513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 12:42:43.695165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 12:42:43.695483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 12:42:43.695777) ========= ========= Total master_lag: 0.18 =========