builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1486474578.41 results: success (0) revision: b57c0a563ecd514d6ec5acc255a9435b6128650b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.411736) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.412411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.412721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.429904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.430290) ========= 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=232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-07 05:36:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 55.2M=0s 2017-02-07 05:36:19 (55.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134813 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.578299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.578658) ========= 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=232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019084 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.628444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:18.628789) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b57c0a563ecd514d6ec5acc255a9435b6128650b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b57c0a563ecd514d6ec5acc255a9435b6128650b --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=232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-07 05:36:19,253 truncating revision to first 12 chars 2017-02-07 05:36:19,253 Setting DEBUG logging. 2017-02-07 05:36:19,253 attempt 1/10 2017-02-07 05:36:19,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b57c0a563ecd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 05:36:19,897 unpacking tar archive at: mozilla-central-b57c0a563ecd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:19.593420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:19.593754) ========= script_repo_revision: b57c0a563ecd514d6ec5acc255a9435b6128650b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:19.594154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:19.594420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 05:36:19.603975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-02-07 05:36:19.604279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:36:20 INFO - MultiFileLogger online at 20170207 05:36:20 in /builds/slave/test 05:36:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:36:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:20 INFO - {'append_to_log': False, 05:36:20 INFO - 'base_work_dir': '/builds/slave/test', 05:36:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:36:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:20 INFO - 'branch': 'Firefox-Non-PGO', 05:36:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:20 INFO - 'config_files': ('talos/linux_config.py',), 05:36:20 INFO - 'default_actions': ('clobber', 05:36:20 INFO - 'read-buildbot-config', 05:36:20 INFO - 'download-and-extract', 05:36:20 INFO - 'populate-webroot', 05:36:20 INFO - 'create-virtualenv', 05:36:20 INFO - 'install', 05:36:20 INFO - 'run-tests'), 05:36:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:20 INFO - 'download_minidump_stackwalk': True, 05:36:20 INFO - 'download_symbols': 'ondemand', 05:36:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:20 INFO - 'installer_path': 'installer.exe', 05:36:20 INFO - 'log_level': 'info', 05:36:20 INFO - 'log_name': 'talos', 05:36:20 INFO - 'log_to_console': True, 05:36:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:36:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:36:20 INFO - 'opt_config_files': (), 05:36:20 INFO - 'pip_index': False, 05:36:20 INFO - 'sps_profile': False, 05:36:20 INFO - 'sps_profile_interval': 0, 05:36:20 INFO - 'suite': 'dromaeojs-e10s', 05:36:20 INFO - 'system_bits': '32', 05:36:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:20 INFO - 'title': 'talos-linux64-ix-025', 05:36:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:20 INFO - 'use_talos_json': True, 05:36:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:20 INFO - 'work_dir': 'build'} 05:36:20 INFO - [mozharness: 2017-02-07 13:36:20.328543Z] Running clobber step. 05:36:20 INFO - Running pre-action listener: _resource_record_pre_action 05:36:20 INFO - Running main action method: clobber 05:36:20 INFO - rmtree: /builds/slave/test/build 05:36:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:20 INFO - Running post-action listener: _resource_record_post_action 05:36:20 INFO - [mozharness: 2017-02-07 13:36:20.810071Z] Finished clobber step (success) 05:36:20 INFO - [mozharness: 2017-02-07 13:36:20.810173Z] Running read-buildbot-config step. 05:36:20 INFO - Running pre-action listener: _resource_record_pre_action 05:36:20 INFO - Running main action method: read_buildbot_config 05:36:20 INFO - Using buildbot properties: 05:36:20 INFO - { 05:36:20 INFO - "project": "", 05:36:20 INFO - "product": "firefox", 05:36:20 INFO - "who": "cbook@mozilla.com", 05:36:20 INFO - "installer_path": "public/build/target.tar.bz2", 05:36:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:36:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:36:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:36:20 INFO - "stage_platform": "linux64", 05:36:20 INFO - "basedir": "/builds/slave/test", 05:36:20 INFO - "buildnumber": 655, 05:36:20 INFO - "platform": "ubuntu64_hw", 05:36:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:36:20 INFO - "slavebuilddir": "test", 05:36:20 INFO - "taskId": "D8NB3LE4T6GZs2g51sWR2Q", 05:36:20 INFO - "branch": "mozilla-central", 05:36:20 INFO - "script_repo_revision": "production", 05:36:20 INFO - "revision": "b57c0a563ecd514d6ec5acc255a9435b6128650b", 05:36:20 INFO - "slavename": "talos-linux64-ix-025", 05:36:20 INFO - "repo_path": "mozilla-central" 05:36:20 INFO - } 05:36:20 INFO - Finding installer, test and symbols from parent task. 05:36:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8NB3LE4T6GZs2g51sWR2Q'}, attempt #1 05:36:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8NB3LE4T6GZs2g51sWR2Q'}, attempt #1 05:36:21 INFO - Task dependencies: dLDVm_EqRZa_BlWLe4eS3w 05:36:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w'}, attempt #1 05:36:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2 05:36:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/test_packages.json 05:36:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.crashreporter-symbols.zip 05:36:22 INFO - Running post-action listener: _resource_record_post_action 05:36:22 INFO - [mozharness: 2017-02-07 13:36:22.195644Z] Finished read-buildbot-config step (success) 05:36:22 INFO - [mozharness: 2017-02-07 13:36:22.195864Z] Running download-and-extract step. 05:36:22 INFO - Running pre-action listener: _resource_record_pre_action 05:36:22 INFO - Running main action method: download_and_extract 05:36:22 INFO - mkdir: /builds/slave/test/build/tests 05:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:22 INFO - trying https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.test_packages.json 05:36:22 INFO - Downloading https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:36:22 INFO - Downloaded 896 bytes. 05:36:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:36:22 INFO - Using the following test package requirements: 05:36:22 INFO - {u'common': [u'target.common.tests.zip'], 05:36:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:36:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:36:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:36:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:36:22 INFO - u'mozbase': [u'target.common.tests.zip'], 05:36:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:36:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:36:22 INFO - u'web-platform': [u'target.common.tests.zip', 05:36:22 INFO - u'target.web-platform.tests.zip'], 05:36:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:36:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:36:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.common.tests.zip 05:36:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:36:22 INFO - Fetch https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.common.tests.zip into memory 05:36:23 INFO - Expected file size: 40181470 05:36:23 INFO - Obtained file size: 40181470 05:36:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:36:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.common.tests.zip 05:36:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:36:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.common.tests.zip into memory 05:36:28 INFO - Expected file size: 40181470 05:36:28 INFO - Obtained file size: 40181470 05:36:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.talos.tests.zip 05:36:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:36:33 INFO - Fetch https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.talos.tests.zip into memory 05:36:34 INFO - Expected file size: 14403454 05:36:34 INFO - Obtained file size: 14403454 05:36: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')]} 05:36:34 INFO - trying https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2 05:36:34 INFO - Downloading https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:36:35 INFO - Downloaded 56314118 bytes. 05:36:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2 05:36:35 INFO - mkdir: /builds/slave/test/properties 05:36:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:35 INFO - Contents: 05:36:35 INFO - build_url:https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2 05:36:35 INFO - Running post-action listener: _resource_record_post_action 05:36:35 INFO - Running post-action listener: set_extra_try_arguments 05:36:35 INFO - [mozharness: 2017-02-07 13:36:35.758972Z] Finished download-and-extract step (success) 05:36:35 INFO - [mozharness: 2017-02-07 13:36:35.759070Z] Running populate-webroot step. 05:36:35 INFO - Running pre-action listener: _resource_record_pre_action 05:36:35 INFO - Running main action method: populate_webroot 05:36:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:35 INFO - '--tppagecycles', 05:36:35 INFO - '7'], 05:36:35 INFO - 'tests': ['tsvgm']}}, 05:36:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:36:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:36:35 INFO - 'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:36:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:36:35 INFO - 'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['damp', 'tps']}, 05:36:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:36:35 INFO - 'tests': ['damp', 'tps']}, 05:36:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['dromaeo_dom']}, 05:36:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['basic_compositor_video']}, 05:36:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:36:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['a11yr', 05:36:35 INFO - 'ts_paint', 05:36:35 INFO - 'tpaint', 05:36:35 INFO - 'sessionrestore', 05:36:35 INFO - 'sessionrestore_no_auto_restore', 05:36:35 INFO - 'tabpaint']}, 05:36:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:35 INFO - 'ts_paint', 05:36:35 INFO - 'tpaint', 05:36:35 INFO - 'sessionrestore', 05:36:35 INFO - 'sessionrestore_no_auto_restore', 05:36:35 INFO - 'tabpaint']}, 05:36:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:36:35 INFO - 'ts_paint', 05:36:35 INFO - 'tpaint', 05:36:35 INFO - 'sessionrestore', 05:36:35 INFO - 'sessionrestore_no_auto_restore', 05:36:35 INFO - 'tabpaint']}, 05:36:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:36:35 INFO - 'ts_paint', 05:36:35 INFO - 'tpaint', 05:36:35 INFO - 'sessionrestore', 05:36:35 INFO - 'sessionrestore_no_auto_restore', 05:36:35 INFO - 'tabpaint']}, 05:36:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['a11yr', 05:36:35 INFO - 'ts_paint', 05:36:35 INFO - 'tpaint', 05:36:35 INFO - 'sessionrestore', 05:36:35 INFO - 'sessionrestore_no_auto_restore', 05:36:35 INFO - 'tabpaint']}, 05:36:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['a11yr', 05:36:35 INFO - 'ts_paint', 05:36:35 INFO - 'tpaint', 05:36:35 INFO - 'sessionrestore', 05:36:35 INFO - 'sessionrestore_no_auto_restore', 05:36:35 INFO - 'tabpaint']}, 05:36:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['tsvgx', 05:36:35 INFO - 'tsvgr_opacity', 05:36:35 INFO - 'tart', 05:36:35 INFO - 'tscrollx', 05:36:35 INFO - 'cart', 05:36:35 INFO - 'tsvg_static']}, 05:36:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:35 INFO - 'tsvgr_opacity', 05:36:35 INFO - 'tart', 05:36:35 INFO - 'tscrollx', 05:36:35 INFO - 'cart', 05:36:35 INFO - 'tsvg_static']}, 05:36:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:36:35 INFO - 'talos_options': ['--disable-e10s'], 05:36:35 INFO - 'tests': ['tp5o']}, 05:36:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:36:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:36:35 INFO - 'talos_options': ['--disable-e10s', 05:36:35 INFO - '--xperf_path', 05:36:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:35 INFO - 'tests': ['tp5n']}, 05:36:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:36:35 INFO - 'talos_options': ['--xperf_path', 05:36:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:35 INFO - 'tests': ['tp5n']}}, 05:36:35 INFO - 'talos.zip': {'path': '', 05:36:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:35 INFO - Running post-action listener: _resource_record_post_action 05:36:35 INFO - [mozharness: 2017-02-07 13:36:35.772484Z] Finished populate-webroot step (success) 05:36:35 INFO - [mozharness: 2017-02-07 13:36:35.772576Z] Running create-virtualenv step. 05:36:35 INFO - Running pre-action listener: _resource_record_pre_action 05:36:35 INFO - Running main action method: create_virtualenv 05:36:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:36:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:36:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:35 INFO - Using real prefix '/usr' 05:36:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:38 INFO - Installing pip.................done. 05:36:38 INFO - Return code: 0 05:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:36:38 INFO - Reading from file tmpfile_stdout 05:36:38 INFO - Output received: 05:36:38 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) 05:36:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:36:38 INFO - Using env: {'DISPLAY': ':0', 05:36:38 INFO - 'HOME': '/home/cltbld', 05:36:38 INFO - 'LANG': 'en_US.UTF-8', 05:36:38 INFO - 'LANGUAGE': 'en_US:en', 05:36:38 INFO - 'LOGNAME': 'cltbld', 05:36:38 INFO - 'MAIL': '/var/mail/cltbld', 05:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:38 INFO - 'MOZ_NO_REMOTE': '1', 05:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:38 INFO - 'NO_EM_RESTART': '1', 05:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:38 INFO - 'PWD': '/builds/slave/test', 05:36:38 INFO - 'SHELL': '/bin/bash', 05:36:38 INFO - 'SHLVL': '1', 05:36:38 INFO - 'TERM': 'linux', 05:36:38 INFO - 'TMOUT': '86400', 05:36:38 INFO - 'USER': 'cltbld', 05:36:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:38 INFO - '_': '/tools/buildbot/bin/python'} 05:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:36:38 INFO - Cleaning up... 05:36:38 INFO - Return code: 0 05:36:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:36:38 INFO - Using env: {'DISPLAY': ':0', 05:36:38 INFO - 'HOME': '/home/cltbld', 05:36:38 INFO - 'LANG': 'en_US.UTF-8', 05:36:38 INFO - 'LANGUAGE': 'en_US:en', 05:36:38 INFO - 'LOGNAME': 'cltbld', 05:36:38 INFO - 'MAIL': '/var/mail/cltbld', 05:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:38 INFO - 'MOZ_NO_REMOTE': '1', 05:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:38 INFO - 'NO_EM_RESTART': '1', 05:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:38 INFO - 'PWD': '/builds/slave/test', 05:36:38 INFO - 'SHELL': '/bin/bash', 05:36:38 INFO - 'SHLVL': '1', 05:36:38 INFO - 'TERM': 'linux', 05:36:38 INFO - 'TMOUT': '86400', 05:36:38 INFO - 'USER': 'cltbld', 05:36:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:38 INFO - '_': '/tools/buildbot/bin/python'} 05:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:38 INFO - Downloading/unpacking psutil>=3.1.1 05:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:41 INFO - Installing collected packages: psutil 05:36:41 INFO - Running setup.py install for psutil 05:36:41 INFO - building 'psutil._psutil_linux' extension 05:36:41 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 05:36:41 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 05:36:41 INFO - building 'psutil._psutil_posix' extension 05:36:41 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 05:36:41 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 05:36:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:41 INFO - Successfully installed psutil 05:36:41 INFO - Cleaning up... 05:36:41 INFO - Return code: 0 05:36:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:36:41 INFO - Using env: {'DISPLAY': ':0', 05:36:41 INFO - 'HOME': '/home/cltbld', 05:36:41 INFO - 'LANG': 'en_US.UTF-8', 05:36:41 INFO - 'LANGUAGE': 'en_US:en', 05:36:41 INFO - 'LOGNAME': 'cltbld', 05:36:41 INFO - 'MAIL': '/var/mail/cltbld', 05:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:41 INFO - 'MOZ_NO_REMOTE': '1', 05:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:41 INFO - 'NO_EM_RESTART': '1', 05:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:41 INFO - 'PWD': '/builds/slave/test', 05:36:41 INFO - 'SHELL': '/bin/bash', 05:36:41 INFO - 'SHLVL': '1', 05:36:41 INFO - 'TERM': 'linux', 05:36:41 INFO - 'TMOUT': '86400', 05:36:41 INFO - 'USER': 'cltbld', 05:36:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:41 INFO - '_': '/tools/buildbot/bin/python'} 05:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:36:43 INFO - Installing collected packages: mozsystemmonitor 05:36:43 INFO - Running setup.py install for mozsystemmonitor 05:36:44 INFO - Successfully installed mozsystemmonitor 05:36:44 INFO - Cleaning up... 05:36:44 INFO - Return code: 0 05:36:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:36:44 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')]} 05:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:44 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')]} 05:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:44 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:44 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 05:36:44 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 05:36:44 INFO - Using env: {'DISPLAY': ':0', 05:36:44 INFO - 'HOME': '/home/cltbld', 05:36:44 INFO - 'LANG': 'en_US.UTF-8', 05:36:44 INFO - 'LANGUAGE': 'en_US:en', 05:36:44 INFO - 'LOGNAME': 'cltbld', 05:36:44 INFO - 'MAIL': '/var/mail/cltbld', 05:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:44 INFO - 'MOZ_NO_REMOTE': '1', 05:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:44 INFO - 'NO_EM_RESTART': '1', 05:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:44 INFO - 'PWD': '/builds/slave/test', 05:36:44 INFO - 'SHELL': '/bin/bash', 05:36:44 INFO - 'SHLVL': '1', 05:36:44 INFO - 'TERM': 'linux', 05:36:44 INFO - 'TMOUT': '86400', 05:36:44 INFO - 'USER': 'cltbld', 05:36:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:44 INFO - '_': '/tools/buildbot/bin/python'} 05:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:36:44 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 05:36:44 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 05:36:44 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 05:36:44 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 05:36:44 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 05:36:44 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 05:36:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:46 INFO - warning: no files found matching '*.txt' 05:36:46 INFO - no previously-included directories found matching 'build' 05:36:46 INFO - no previously-included directories found matching 'dist' 05:36:46 INFO - no previously-included directories found matching '.git*' 05:36:46 INFO - Installing collected packages: jsonschema, functools32 05:36:46 INFO - Running setup.py install for functools32 05:36:46 INFO - warning: no files found matching '*.txt' 05:36:46 INFO - no previously-included directories found matching 'build' 05:36:46 INFO - no previously-included directories found matching 'dist' 05:36:46 INFO - no previously-included directories found matching '.git*' 05:36:46 INFO - Successfully installed jsonschema functools32 05:36:46 INFO - Cleaning up... 05:36:46 INFO - Return code: 0 05:36:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:36:46 INFO - Using env: {'DISPLAY': ':0', 05:36:46 INFO - 'HOME': '/home/cltbld', 05:36:46 INFO - 'LANG': 'en_US.UTF-8', 05:36:46 INFO - 'LANGUAGE': 'en_US:en', 05:36:46 INFO - 'LOGNAME': 'cltbld', 05:36:46 INFO - 'MAIL': '/var/mail/cltbld', 05:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:46 INFO - 'MOZ_NO_REMOTE': '1', 05:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:46 INFO - 'NO_EM_RESTART': '1', 05:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:46 INFO - 'PWD': '/builds/slave/test', 05:36:46 INFO - 'SHELL': '/bin/bash', 05:36:46 INFO - 'SHLVL': '1', 05:36:46 INFO - 'TERM': 'linux', 05:36:46 INFO - 'TMOUT': '86400', 05:36:46 INFO - 'USER': 'cltbld', 05:36:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:46 INFO - '_': '/tools/buildbot/bin/python'} 05:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:36:47 INFO - Cleaning up... 05:36:47 INFO - Return code: 0 05:36:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:47 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')]} 05:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:47 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')]} 05:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:47 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:47 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 05:36:47 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 05:36:47 INFO - Using env: {'DISPLAY': ':0', 05:36:47 INFO - 'HOME': '/home/cltbld', 05:36:47 INFO - 'LANG': 'en_US.UTF-8', 05:36:47 INFO - 'LANGUAGE': 'en_US:en', 05:36:47 INFO - 'LOGNAME': 'cltbld', 05:36:47 INFO - 'MAIL': '/var/mail/cltbld', 05:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:47 INFO - 'MOZ_NO_REMOTE': '1', 05:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:47 INFO - 'NO_EM_RESTART': '1', 05:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:47 INFO - 'PWD': '/builds/slave/test', 05:36:47 INFO - 'SHELL': '/bin/bash', 05:36:47 INFO - 'SHLVL': '1', 05:36:47 INFO - 'TERM': 'linux', 05:36:47 INFO - 'TMOUT': '86400', 05:36:47 INFO - 'USER': 'cltbld', 05:36:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:47 INFO - '_': '/tools/buildbot/bin/python'} 05:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:47 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 05:36:47 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 05:36:47 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 05:36:47 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 05:36:47 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 05:36:47 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 05:36:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:49 INFO - Downloading docopt-0.6.1.tar.gz 05:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:50 INFO - Running setup.py install for blobuploader 05:36:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:50 INFO - Running setup.py install for requests 05:36:50 INFO - Running setup.py install for docopt 05:36:50 INFO - Successfully installed blobuploader requests docopt 05:36:50 INFO - Cleaning up... 05:36:50 INFO - Return code: 0 05:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:50 INFO - Using env: {'DISPLAY': ':0', 05:36:50 INFO - 'HOME': '/home/cltbld', 05:36:50 INFO - 'LANG': 'en_US.UTF-8', 05:36:50 INFO - 'LANGUAGE': 'en_US:en', 05:36:50 INFO - 'LOGNAME': 'cltbld', 05:36:50 INFO - 'MAIL': '/var/mail/cltbld', 05:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:50 INFO - 'MOZ_NO_REMOTE': '1', 05:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:50 INFO - 'NO_EM_RESTART': '1', 05:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:50 INFO - 'PWD': '/builds/slave/test', 05:36:50 INFO - 'SHELL': '/bin/bash', 05:36:50 INFO - 'SHLVL': '1', 05:36:50 INFO - 'TERM': 'linux', 05:36:50 INFO - 'TMOUT': '86400', 05:36:50 INFO - 'USER': 'cltbld', 05:36:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:50 INFO - '_': '/tools/buildbot/bin/python'} 05:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:50 INFO - Running setup.py (path:/tmp/pip-PPZKQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:50 INFO - Running setup.py (path:/tmp/pip-IlCPyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:51 INFO - Running setup.py (path:/tmp/pip-tLgT9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:51 INFO - Running setup.py (path:/tmp/pip-Lyb7DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:51 INFO - Running setup.py (path:/tmp/pip-Wuwsxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:51 INFO - Running setup.py (path:/tmp/pip-dJ345C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:51 INFO - Running setup.py (path:/tmp/pip-hZo_Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:51 INFO - Running setup.py (path:/tmp/pip-Dp3HGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:51 INFO - Running setup.py (path:/tmp/pip-jAbCWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:51 INFO - Running setup.py (path:/tmp/pip-mJcJZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:51 INFO - Running setup.py (path:/tmp/pip-yIN76v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:51 INFO - Running setup.py (path:/tmp/pip-tYvZoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:51 INFO - Running setup.py (path:/tmp/pip-BVV4Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:51 INFO - Running setup.py (path:/tmp/pip-j5hC7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:51 INFO - Running setup.py (path:/tmp/pip-CqSV0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:51 INFO - Running setup.py (path:/tmp/pip-J36KTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:52 INFO - Running setup.py (path:/tmp/pip-eZ6j1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:52 INFO - Running setup.py install for manifestparser 05:36:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Running setup.py install for mozcrash 05:36:52 INFO - Running setup.py install for mozdebug 05:36:52 INFO - Running setup.py install for mozdevice 05:36:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Running setup.py install for mozfile 05:36:52 INFO - Running setup.py install for mozhttpd 05:36:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Running setup.py install for mozinfo 05:36:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Running setup.py install for mozInstall 05:36:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:52 INFO - Running setup.py install for mozleak 05:36:53 INFO - Running setup.py install for mozlog 05:36:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:53 INFO - Running setup.py install for moznetwork 05:36:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:53 INFO - Running setup.py install for mozprocess 05:36:53 INFO - Running setup.py install for mozprofile 05:36:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:53 INFO - Running setup.py install for mozrunner 05:36:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:53 INFO - Running setup.py install for mozscreenshot 05:36:53 INFO - Running setup.py install for moztest 05:36:53 INFO - Running setup.py install for mozversion 05:36:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:53 INFO - Cleaning up... 05:36:53 INFO - Return code: 0 05:36:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:53 INFO - Using env: {'DISPLAY': ':0', 05:36:53 INFO - 'HOME': '/home/cltbld', 05:36:53 INFO - 'LANG': 'en_US.UTF-8', 05:36:53 INFO - 'LANGUAGE': 'en_US:en', 05:36:53 INFO - 'LOGNAME': 'cltbld', 05:36:53 INFO - 'MAIL': '/var/mail/cltbld', 05:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:53 INFO - 'MOZ_NO_REMOTE': '1', 05:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:53 INFO - 'NO_EM_RESTART': '1', 05:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:53 INFO - 'PWD': '/builds/slave/test', 05:36:53 INFO - 'SHELL': '/bin/bash', 05:36:53 INFO - 'SHLVL': '1', 05:36:53 INFO - 'TERM': 'linux', 05:36:53 INFO - 'TMOUT': '86400', 05:36:53 INFO - 'USER': 'cltbld', 05:36:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:53 INFO - '_': '/tools/buildbot/bin/python'} 05:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:54 INFO - Running setup.py (path:/tmp/pip-_7DHSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:54 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)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:54 INFO - Running setup.py (path:/tmp/pip-aIiO3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:54 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)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:54 INFO - Running setup.py (path:/tmp/pip-2bvhTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:54 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)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:54 INFO - Running setup.py (path:/tmp/pip-m8YkWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:54 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)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:54 INFO - Running setup.py (path:/tmp/pip-xf0rRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:54 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)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:54 INFO - Running setup.py (path:/tmp/pip-J87D7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:54 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)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:54 INFO - Running setup.py (path:/tmp/pip-AgiZM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:54 INFO - Running setup.py (path:/tmp/pip-KIX8Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:54 INFO - Running setup.py (path:/tmp/pip-yI8VIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:54 INFO - Running setup.py (path:/tmp/pip-AeC_9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:54 INFO - Running setup.py (path:/tmp/pip-mZcs9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:54 INFO - Running setup.py (path:/tmp/pip-Q_buPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:55 INFO - Running setup.py (path:/tmp/pip-8ik_gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:55 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)) 05:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:55 INFO - Running setup.py (path:/tmp/pip-x_c2cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:55 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)) 05:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:55 INFO - Running setup.py (path:/tmp/pip-F5I5YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:55 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)) 05:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:55 INFO - Running setup.py (path:/tmp/pip-w_aNDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:55 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)) 05:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:55 INFO - Running setup.py (path:/tmp/pip-gyQfuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:55 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)) 05:36:55 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)) 05:36:55 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)) 05:36:55 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)) 05:36:55 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)) 05:36:55 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)) 05:36:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:55 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 05:36:55 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 05:36:55 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 05:36:55 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 05:36:55 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 05:36:55 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 05:36:57 INFO - Downloading blessings-1.6.tar.gz 05:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:57 INFO - Installing collected packages: blessings 05:36:57 INFO - Running setup.py install for blessings 05:36:57 INFO - Successfully installed blessings 05:36:57 INFO - Cleaning up... 05:36:57 INFO - Return code: 0 05:36:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:57 INFO - Reading from file tmpfile_stdout 05:36:57 INFO - Current package versions: 05:36:57 INFO - argparse == 1.2.1 05:36:57 INFO - blessings == 1.6 05:36:57 INFO - blobuploader == 1.2.4 05:36:57 INFO - docopt == 0.6.1 05:36:57 INFO - functools32 == 3.2.3-2 05:36:57 INFO - jsonschema == 2.5.1 05:36:57 INFO - manifestparser == 1.1 05:36:57 INFO - mozInstall == 1.12 05:36:57 INFO - mozcrash == 1.0 05:36:57 INFO - mozdebug == 0.1 05:36:57 INFO - mozdevice == 0.49 05:36:57 INFO - mozfile == 1.2 05:36:57 INFO - mozhttpd == 0.7 05:36:57 INFO - mozinfo == 0.9 05:36:57 INFO - mozleak == 0.1 05:36:57 INFO - mozlog == 3.4 05:36:57 INFO - moznetwork == 0.27 05:36:57 INFO - mozprocess == 0.24 05:36:57 INFO - mozprofile == 0.28 05:36:57 INFO - mozrunner == 6.13 05:36:57 INFO - mozscreenshot == 0.1 05:36:57 INFO - mozsystemmonitor == 0.3 05:36:57 INFO - moztest == 0.8 05:36:57 INFO - mozversion == 1.4 05:36:57 INFO - psutil == 3.1.1 05:36:57 INFO - requests == 1.2.3 05:36:57 INFO - wsgiref == 0.1.2 05:36:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:57 INFO - Using env: {'DISPLAY': ':0', 05:36:57 INFO - 'HOME': '/home/cltbld', 05:36:57 INFO - 'LANG': 'en_US.UTF-8', 05:36:57 INFO - 'LANGUAGE': 'en_US:en', 05:36:57 INFO - 'LOGNAME': 'cltbld', 05:36:57 INFO - 'MAIL': '/var/mail/cltbld', 05:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:57 INFO - 'MOZ_NO_REMOTE': '1', 05:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:57 INFO - 'NO_EM_RESTART': '1', 05:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:57 INFO - 'PWD': '/builds/slave/test', 05:36:57 INFO - 'SHELL': '/bin/bash', 05:36:57 INFO - 'SHLVL': '1', 05:36:57 INFO - 'TERM': 'linux', 05:36:57 INFO - 'TMOUT': '86400', 05:36:57 INFO - 'USER': 'cltbld', 05:36:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:57 INFO - '_': '/tools/buildbot/bin/python'} 05:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 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)) 05:36:58 INFO - Cleaning up... 05:36:58 INFO - Return code: 0 05:36:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:58 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')]} 05:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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')]} 05:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, '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': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', '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 05:36:58 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 05:36:58 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 05:36:58 INFO - Using env: {'DISPLAY': ':0', 05:36:58 INFO - 'HOME': '/home/cltbld', 05:36:58 INFO - 'LANG': 'en_US.UTF-8', 05:36:58 INFO - 'LANGUAGE': 'en_US:en', 05:36:58 INFO - 'LOGNAME': 'cltbld', 05:36:58 INFO - 'MAIL': '/var/mail/cltbld', 05:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:58 INFO - 'MOZ_NO_REMOTE': '1', 05:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:58 INFO - 'NO_EM_RESTART': '1', 05:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:58 INFO - 'PWD': '/builds/slave/test', 05:36:58 INFO - 'SHELL': '/bin/bash', 05:36:58 INFO - 'SHLVL': '1', 05:36:58 INFO - 'TERM': 'linux', 05:36:58 INFO - 'TMOUT': '86400', 05:36:58 INFO - 'USER': 'cltbld', 05:36:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:58 INFO - '_': '/tools/buildbot/bin/python'} 05:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:36:58 INFO - Cleaning up... 05:36:58 INFO - Return code: 0 05:36:58 INFO - Running post-action listener: _resource_record_post_action 05:36:58 INFO - Running post-action listener: _start_resource_monitoring 05:36:58 INFO - Starting resource monitoring. 05:36:58 INFO - [mozharness: 2017-02-07 13:36:58.329392Z] Finished create-virtualenv step (success) 05:36:58 INFO - [mozharness: 2017-02-07 13:36:58.329845Z] Running install step. 05:36:58 INFO - Running pre-action listener: _resource_record_pre_action 05:36:58 INFO - Running main action method: install 05:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:58 INFO - Reading from file tmpfile_stdout 05:36:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:58 INFO - Reading from file tmpfile_stdout 05:36:58 INFO - Output received: 05:36:58 INFO - Usage: mozinstall [options] installer 05:36:58 INFO - Options: 05:36:58 INFO - -h, --help show this help message and exit 05:36:58 INFO - -d DEST, --destination=DEST 05:36:58 INFO - Directory to install application into. [default: 05:36:58 INFO - "/builds/slave/test"] 05:36:58 INFO - --app=APP Application being installed. [default: firefox] 05:36:58 INFO - mkdir: /builds/slave/test/build/application 05:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:37:14 INFO - Reading from file tmpfile_stdout 05:37:14 INFO - Output received: 05:37:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:37:14 INFO - Running post-action listener: _resource_record_post_action 05:37:14 INFO - [mozharness: 2017-02-07 13:37:14.881465Z] Finished install step (success) 05:37:14 INFO - [mozharness: 2017-02-07 13:37:14.881620Z] Running run-tests step. 05:37:14 INFO - Running pre-action listener: _resource_record_pre_action 05:37:14 INFO - Running main action method: run_tests 05:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:14 INFO - Python 2.7.3 05:37:14 INFO - Return code: 0 05:37:14 INFO - grabbing minidump binary from tooltool 05:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f820>, '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 0x1d30520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d309b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:37:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:37:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:37:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:14 INFO - Return code: 0 05:37:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:37:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:37:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 05:37:14 INFO - Using env: {'DISPLAY': ':0', 05:37:14 INFO - 'HOME': '/home/cltbld', 05:37:14 INFO - 'LANG': 'en_US.UTF-8', 05:37:14 INFO - 'LANGUAGE': 'en_US:en', 05:37:14 INFO - 'LOGNAME': 'cltbld', 05:37:14 INFO - 'MAIL': '/var/mail/cltbld', 05:37:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:14 INFO - 'MOZ_NO_REMOTE': '1', 05:37:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:14 INFO - 'NO_EM_RESTART': '1', 05:37:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:14 INFO - 'PWD': '/builds/slave/test', 05:37:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:14 INFO - 'SHELL': '/bin/bash', 05:37:14 INFO - 'SHLVL': '1', 05:37:14 INFO - 'TERM': 'linux', 05:37:14 INFO - 'TMOUT': '86400', 05:37:14 INFO - 'USER': 'cltbld', 05:37:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793', 05:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:14 INFO - '_': '/tools/buildbot/bin/python'} 05:37:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:37:15 INFO - mozversion application_buildid: 20170207130748 05:37:15 INFO - mozversion application_changeset: b57c0a563ecd514d6ec5acc255a9435b6128650b 05:37:15 INFO - mozversion application_display_name: Nightly 05:37:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:15 INFO - mozversion application_name: Firefox 05:37:15 INFO - mozversion application_remotingname: firefox 05:37:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:15 INFO - mozversion application_vendor: Mozilla 05:37:15 INFO - mozversion application_version: 54.0a1 05:37:15 INFO - mozversion platform_buildid: 20170207130748 05:37:15 INFO - mozversion platform_changeset: b57c0a563ecd514d6ec5acc255a9435b6128650b 05:37:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:15 INFO - mozversion platform_version: 54.0a1 05:37:15 INFO - using testdate: 1486474635 05:37:15 INFO - actual date: 1486474635 05:37:15 INFO - starting webserver on 'localhost:45595' 05:37:15 INFO - SUITE-START | Running 2 tests 05:37:15 INFO - TEST-START | dromaeo_css 05:37:15 INFO - operating with platform_type : linux_ 05:37:15 INFO - Initialising browser for dromaeo_css test... 05:37:15 INFO - TEST-INFO | started process 6941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTMO14k/profile http://localhost:45595/getInfo.html) 05:37:19 INFO - PROCESS | 6941 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:37:19 INFO - PROCESS | 6941 | __metrics Screen width/height:1600/1200 05:37:19 INFO - PROCESS | 6941 | colorDepth:24 05:37:19 INFO - PROCESS | 6941 | Browser inner width/height: 1024/697 05:37:19 INFO - PROCESS | 6941 | __metrics 05:37:20 INFO - PROCESS | 6941 | 1486474640690 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6310:36 < canClose@browser.js:5176:12 < forceQuit@jar:file:///tmp/tmpTMO14k/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpTMO14k/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpTMO14k/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpTMO14k/profile/extensions/talos-powers@TalosPowersService.js:55:9 05:37:20 ERROR - PROCESS | 6941 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:37:21 INFO - TEST-INFO | 6941: exit 0 05:37:21 INFO - Browser initialized. 05:37:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:21 INFO - TEST-INFO | started process 7058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTMO14k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:33 INFO - PROCESS | 7058 | RSS: Main: 159543296 05:37:33 INFO - PROCESS | 7058 | 05:40:37 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:45595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45595/tests/dromaeo/cssquery-ext.html) 05:40:40 INFO - PROCESS | 7058 | RSS: Main: 169082880 05:40:40 INFO - PROCESS | 7058 | 05:42:22 INFO - PROCESS | 7058 | ************************* 05:42:22 INFO - PROCESS | 7058 | A coding exception was thrown and uncaught in a Task. 05:42:22 INFO - PROCESS | 7058 | 05:42:22 ERROR - PROCESS | 7058 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:42:22 INFO - PROCESS | 7058 | Full stack: 05:42:22 INFO - PROCESS | 7058 | ************************* 05:43:42 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:45595/tests/dromaeo/cssquery-ext.html (next: http://localhost:45595/tests/dromaeo/cssquery-jquery.html) 05:43:43 INFO - PROCESS | 7058 | RSS: Main: 163979264 05:43:43 INFO - PROCESS | 7058 | 05:46:45 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:45595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45595/tests/dromaeo/cssquery-mootools.html) 05:46:46 INFO - PROCESS | 7058 | RSS: Main: 171347968 05:46:46 INFO - PROCESS | 7058 | 05:49:48 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:45595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45595/tests/dromaeo/cssquery-prototype.html) 05:49:49 INFO - PROCESS | 7058 | RSS: Main: 163971072 05:49:49 INFO - PROCESS | 7058 | 05:52:52 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:45595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45595/tests/dromaeo/cssquery-yui.html) 05:52:53 INFO - PROCESS | 7058 | RSS: Main: 168210432 05:52:53 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:45595/tests/dromaeo/cssquery-yui.html (next: http://localhost:45595/tests/dromaeo/cssquery-dojo.html) 05:55:56 INFO - PROCESS | 7058 | RSS: Main: 169664512 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | __start_tp_report 05:55:56 INFO - PROCESS | 7058 | _x_x_mozilla_page_load 05:55:56 INFO - PROCESS | 7058 | _x_x_mozilla_page_load_details 05:55:56 INFO - PROCESS | 7058 | |i|pagename|runs| 05:55:56 INFO - PROCESS | 7058 | |0;dojo.html;2610.634511168437;2612.294680436281;2619.816612837101;2631.065971580089;2668.0661768381055;4714.834980775673;4843.273508973652;4855.781489832962;4857.028594281149;4864.07582559314;4739.194336962716;4859.562639362457;4862.927056094161;4864.513548645134;4865.124277630034;4437.2234858899565;4453.3097369907555;4490.865274041767;4525.796339164745;4542.727436353813;4481.887952801173;4555.134524440362;4558.5213552577;4566.337881007252;4570.588647021767;4341.848035318749;4375.059362237134;4495.415595972535;4503.166914120898;4549.47681016684;4368;4404.2512772828695;4439.866803995886;4457.0194557197365;4470.709403888769;4356.607905288539;4416.734995900256;4426.3581780641625;4436.622887054572;4450.532694067108;4601.907961840778;4795.040991801654;4814.759262036884;4817.951820481785;4837.467878533358;5000.849974500771;5067.873303167414;5090.669106508065;5092.10888094582;5121.103806833789;5160.40655324635;5192;5195.636305458619;5196.740162991835;5255.527002569749;4846.854594362175;4848.757562121915;4850.296706977469;4856.514348565186;4906.779194936236;5155.664881782672;5174.663646862942;5277.419483856773;5295.099833028395;5297;5125.410577783528;5126.53861152498;5136.280920671109;5152.355955505562;5177.974110129425;5032.421271553745;5059.797608095709;5101.158308879068;5112.821051263188;5215.348081489814;5054.519820617109;5107.387113546398;5118;5119.0529751996;5156.613254005964;4944.184209605375;5050.393952725696;5120.7951681933055;5165.586753059746;5175.922361164586;4460.464744230713;4465.441819772528;4475.485319188335;4496.325551167286;4512.81948722054;3819.6944244460933;3827.2919509890758;3828.3300422425964;3844.019774957368;3878.941815872764;4372.737635741865;4461.5092339842595;4471.441069866267;4510.1656193604285;4536.455625324916;5151.6908985461;5217.530422261939;5236.397814251333;5265.7103859287345;5269.314989051475;4511.481179664315;4515.706479078849;4516.751578663139;4520.321951707205;4564.657650676212;4590.862274131781;4632.189366860718;4699.459562150397;4717.646176536773;4744.122337367598;4840.419149702058;4841.2496063110275;4853.49038350968;4887.242477416006;4929.852104436873;5176.792928282826;5178.792848286026;5179;5224.2947202127225;5300.655457395257;4694.694844835075;4835.903281934412;4843;4845.781939812788;4892.975535122301;4959.256111583291;5030.0694371541385;5072.010957863181;5085.389753229636;5087.23691446286;5087.23691446286;5154.7938082477785;5155.7164355959285;5156.793728250978;5159.277701121771;4969.0807200668;4982.6512144149565;4997.225430058346;5008.6243531734535;5043.218301163325;5013.523715247045;5027.572656324253;5029.924551131663;5041.974790126026;5046.1673823818655;4904.288878112725;4926.876828079184;4945.455999839943;4962.082014827269;4964.950350496449;4910.288008238714;4937.456879743154;4948.307236986752;4970.527799859007;5110.846674599619;4835.564799167951;4873.610111191168;4879.219324907997;4880.755962201947;4882.633802464758 05:55:56 INFO - PROCESS | 7058 | |1;ext.html;491.2434850330491;505.8887044850134;514.4778050278966;521.4524749013535;567.4212303450483;33802.83098584507;37078.07304817378;37404.81297593515;37542.436863447;37637.43543846845;37505.62494375062;37973;37993.81003094988;38033.42949855755;38046.42930356047;7452.515586486875;7610.200928902441;9090.454572725657;9550.80898382032;9563.713088607354;9260.073992600719;9379.953100234488;9404.38871473352;9424;9476.573554190078;9413.199878010377;9491;9561.235101191887;9563.330566860323;9579.042095790435;9353.345265831394;9448.385854919443;9486.245044666759;9501.952490237574;9536.666216682383;9360.204382627417;9396.812063758754;9403.341766076377;9428.434293942386;9458.90541094594;33119.6688033119;33318.66681333204;33341;33358;33360.332793343994;3348.3470723208984;3395.168183794986;3460.3598334308235;3519.1026288296575;3524.365614189445;23402;24773.380665483328;24895.128670496444;24920.626190607156;25712.100076497234;3438.621751607321;3470.6182319944787;3502.247016891355;3508.3684936711384;3517.4723791431234;228964;233506;236362.81818590968;236981;237172;30498;32079;32187.67812321847;33455.498167527505;46328.768356158675;32824;32825;32970;32986.83506582452;33096.66903330984;10989.560417583367;11056.668299951014;11126.276792008493;11162.832557511643;11211.047060999743;8646.054637706466;8905.821883562423;8924.241439477717;8949.149830766068;8993.910060899307;7855.842883142305;7868.527888326718;7986.0816006158875;8015.959920200478;8095.959520202361;3162.905112846618;3194;3200.4079245339685;3204.439223135942;3226.870925162967;747.7009196321407;762.9961850190714;763.6678045050421;773.2963003666637;777.7316825695126;24689.753102469105;26426.339341516617;26461.221571735077;27280.863595681894;27674.169774906786;913.7487191022522;920.2362039507193;934.1592566690033;938.5635679409107;1017.577705252312;13515.391807368693;13981.23103229332;14281.78577321341;14610.561683149523;14611.634709132144;323669;325031;328037;328490;330393;47612.761936190094;48519;48535.51464485381;48578.51421485811;48588.27117593239;1155.231770872394;1198.0774803401507;1204.0488014468647;1211.0493262788668;1211.7515909238584;24844.37889052788;25334.74665253324;26385.73614263833;26582.7341726588;26749;41556.16887662169;42487;42584.14831703411;42595.57404425916;42752.57247427486;214848;216122;216326;216331;217493;24916.0033598654;38565;40127.59872401239;40321.798391007855;42176.78911605422;38416.80791596136;38595.421068684554;40098.59901400949;42083.579164207964;42694.78652606717;35714.821425892704;36288.27423451569;36621.26757464889;37394.43908341431;37677;35368;36293;36497.635023649425;36855.8157209223;36971.26057478889;34532.65467345395;34829.65170348366;35335.46996794999;35417.29165416729;35890.46164307485;30195.69804301929;32481;33181.33637327288;33187.33625327432;33296.836800503916;24059.157929472385;24689.135880244106;24950.37624059413;25157;25200 05:55:56 INFO - PROCESS | 7058 | |2;jquery.html;373.9738218324715;375.4968342421156;390.6894019254693;399.2753153027257;414.5046669230269;16053.58186367791;17381;18195.545111372205;18196.909015454905;18209.362672306474;17191.570210744736;17395;17627;17814.109294535287;18193.7270940936;5063.164577844651;5278.2082687596785;5286.7885284588765;5286.947130528703;5292.364916210041;5030;5046.167382381903;5155.793768249266;5161.406438259611;5265.552428043621;5093.057784309896;5100.566451851579;5110.029094472057;5127.7948882044675;5134.0758663440565;4944.35723355965;5109.642325037249;5129.820456284012;5131.153359695664;5135.897282054338;4563.018950925567;4567.200739870509;4582.656300777455;4590.357349971006;4590.563896429834;21086.367408977756;21204.575908481896;21261.255856045118;21400;21676.674849877265;2207.6136676081624;2255.2670382125875;2259.401258666455;2271.216430331533;2350.4593943392942;11978.041756659533;12775.872241277653;13241.867581324159;13469.797953030713;13815.723685526335;1665.5919299771513;1673.5397765614432;1673.6485338078896;1704.411977867646;1716.5708572856786;74020;74986.87519687155;75023;76227.99999999945;76479;10796.190285728602;10972.451377431096;11028.613998510014;11084.113270938306;11240.325580465198;15234.847651523343;15315.92342038305;15361.615959600877;15370.923145384426;15373.615659608598;7074.347011715145;7113.75101871432;7117.110361204849;7172.103487064117;7246.094238220223;6365.49076073913;6422.582532135396;6596.076549283008;6641.734330626818;6652.667366631746;4347.608715215582;4442.422485076984;4502.797374118172;4621.60716339115;4663.230566956482;1872.1107473949764;1917.4439412570478;1925.913333899978;1980.6434841728628;1993.3023441795256;933.9159475647224;957.9904200958041;962.7978124593914;994.5275993902839;998.4907697074544;16240.51278461648;16623.91688041552;17334.739978900325;17773;18035.63928721418;933.7852293972288;951.509972364233;954.2890546542732;955.302629080761;960.3565611040619;9391.248700103975;9722.708318750449;9888.950555247322;9896;9942.850857237147;463333;468054;476819;478189;478201;67422;71518.64240678867;80810.59594702107;81342.11947283182;85254;900.9549522523979;911.6809116809063;934.7149119518476;936.798588303518;938.7887725261761;14778.261086945824;14999.025063370846;15538.922305388402;15722.764158537402;15821.446249381217;36357.27285454223;37310.81344593368;37787.24425511529;37797.67708130202;38745.6125438742;50250;50399;50585;51512.22731658953;53089.734551327;7189.137303523401;7458.694728422396;7534.886976695244;7566.281203285899;7718.768436946901;8591.097934717014;10785;10830.945845270724;10999.670009899715;11169.441527923735;8467.915320846712;8783.12168783142;9418.199453046567;10095;10608.416537090534;9308.627654893728;9776.364536305402;9917.404955702681;10636.255462117577;10787.892121078688;10309.381437113798;10364.222683298633;10571.418571978615;10669.35983840972;11140.331580104896;7720.189380115007;7728.22250882289;7768.92231077682;7828.569428681477;7830.608469576612;9603.615855365708;9641.42151470914;9759.219262458844;9920.652777152765;10102.725188895527 05:55:56 INFO - PROCESS | 7058 | |3;mootools.html;1324.6886981559326;1328.2229895511132;1339.7454483648105;1355.4984655677401;1363.5841068474117;7170.211276759553;7290.963545182267;7644.312011918926;7669.309762121408;7701.037370328716;7615.086189657235;7915.248051435119;7933.682652693899;7936.127026027132;7939.642716077776;2111.556573119643;2146.9892650536726;2154.3213887625425;2155.795199456049;2163.4266919266406;1843.5667618109733;1918.3669389101563;2097.255474306622;2106;2144.4210063282903;2080.843936704746;2131.3392848217027;2132.136484723682;2133.157402825883;2140.550484398278;2033.1164344406918;2050.6411378008866;2051.200031987526;2056.0953180600486;2065.473304307407;1931.121339790392;2052.9692054619045;2136.2629892686996;2137.4122116417952;2138.422625891016;7457.254274572553;7536.585487798169;7546.169921308651;7546.50947688404;7559.622018899088;4569.588737013684;4723.858284251478;4731.384919960383;4736.431628204603;4737.502562230985;2860.184847318525;3023.833689147096;3072.3701641163507;3085.5988721466065;3096.8606412711483;1125.1786196076828;1184.6150001249628;1201.5013769285824;1207.0705556721364;1209.7580483903255;9955.950220248853;9966.451845148515;9995.250356223312;10007.399556026661;10111.49442527878;3785.6782173515007;3948.0919388540797;4014.116894283253;4019.517657881073;4171.10321280926;8221.301189398848;8309.45988510757;8311.25198732117;8338.24955753973;8343.207395297437;4518.209313370147;4556.202664533694;4589.701669391479;4670.696404733681;4692.061587682477;4113.547509773923;4130.648894843972;4225.535191128974;4229.936550951738;4233.1956928183545;3315.8839440619463;3347.3305338931823;3421.3157368526395;3425.469052296848;3446.5174875517446;946.8769060022153;979.8236317462782;1001.6944831826363;1026.712520494263;1052.9417934975454;658.6937074260492;661.2329697550817;676.8003987042113;819.4059307002494;833.6582001379405;4960.751962401865;5004.9499505005215;5130.846074617767;5262.92105618416;5298.284731561267;846.5513277962566;863.3179787967435;898.1961144775389;900.293269783217;913.6345461815328;3423.2297733009873;3462.6364231755806;3486.633903440153;3548.964510354915;3597.869853227656;9146.131117543822;9419.24646028316;9419.764505887408;9430.387024843363;9438.716838494856;9169.40398874071;9371.250299975985;9374.203192728695;9392.671256506126;9419.952900235456;7022.262662420474;7264.527805692507;7273.89089163663;7276;7284.053073100569;4871.561559459524;4975.997367935604;5054.194921818426;5127.769250383816;5137.974310128426;8275.50346979183;8355.874661879956;8422.789430264293;8425.789355266168;8532.104129066607;8523.74428767138;8627.611757470804;8631.352648551258;8657.567121643766;8697.08680588529;6179.81460556184;6289.40250676185;6292.087647291209;6293.37066293367;6297.118403423616;6986.196587392515;7056.929430705627;7102.609356485443;7118.928810711826;7168.319009694071;5754.309482862083;6365.077063825812;6426;6470.579412338371;6515.218173819172;6352.68236588178;6353.3011368748475;6400.967995159995;6454;6473.741050357933;5776.162456443708;5873.207117039145;5877.471027607536;5886.911696324473;5888.793892213924;4379.255526560556;4420.403245561936;4501.459824820911;4504.324351347193;4514.232580461264;4391.692581519263;4437.312216606431;4457.576530229623;4492.9775351123035;4521.434820647419 05:55:56 INFO - PROCESS | 7058 | |4;prototype.html;358.1744079895839;362.7660159197318;366.90277076574694;368.2763369977994;377.73369774309134;4814.603764908177;4825.324454576357;4842.8547143585665;4907.337509436234;4908;4745.57289843914;4772.403449568804;4801.079568172724;4900.583450406711;4933.013397320532;3693.722970777189;3727.4036154215332;3826.961730382702;3850.24920140572;3874.2638898609316;3808.8095595220266;3818.847246110166;3869.922601547967;3882.5833266725244;3892.8832135035996;3782.7352085354037;3811.1805961718223;3832.6550610445056;3856.8842934712;3898.2203559288114;3731.477593136963;3796.316663000659;3870.593587673296;3879.4568760373572;3883.864064757734;3332.750043746729;3377.5681509313254;3380.4956794226578;3400.500632035452;3424.6746559076846;4801.895564020295;4807.879803004917;4815.759212039384;4822.348982887301;4869.975650121763;4247.5964783345535;4364.650827933758;4365.323374876899;4395.626371758372;4430.136123455927;4959.652234741571;5031.421386540558;5135.64050516464;5168.612354073422;5175.353080864892;3638.308721342936;3651.8454112074005;3655.4334078217917;3668.853245870162;3685.2261025184744;5176;5200.29795977542;5287;5407.675539467645;5488.1493368527945;3662.8278950735507;3706.462562928414;3719.7210209234418;3723;3741.110739076749;3744.756590821588;3765.585785563586;3789.6020917803785;3807.3908174691915;3848.5189351331082;4186.451013125164;4328.156009578165;4349.847755328548;4375.649948004152;4378.7372757634;5020.523050310215;5095.541401273903;5104.412992505835;5108.846734597968;5137.51193636604;1188.6434069779032;1198.2570806100273;1210.5352523446727;1221.9511219551296;1229.766344394562;840.848647243502;861.7759382560454;877.368294827723;878.3017501086651;892.3485855325648;4248.766317852548;4274.6962176535835;4279.507856596531;4284.564670835242;4359.912801743947;5002.924956125661;5063.949360506422;5064.366529404689;5150.562202212779;5157;4371.978140109279;4388.188185185751;4404.436425069054;4463.419755431838;4475.397305169305;2526.7220605733355;2658.122819469609;2709.4851978124093;2728.2224565998595;2730.699623041464;4664.790084446208;4726.109556177556;4739.9763001185465;4804.591609713144;4888.5111488850835;5106.795728170831;5227.3465816772905;5266.368035835724;5293.8411847643865;5396.325459317585;4892.828750993769;4936.210206367035;4940.2342636891335;4974.253861920669;4986.376702912136;5251.36983561975;5335.386430560535;5358.46415358461;5386.192071189353;5390.4879036491475;4948.430930443045;5226.27532914145;5232.2936403586555;5266.947330526646;5270.920936186037;4737.857864264078;4831.323614694016;4866.610671146229;4981.277714731416;5005.499450054966;3643.5081264030077;3697.7041836652465;3710.332140214787;3774.698024158116;3804.505414296124;5291.930680205549;5328.387235467971;5349.224362467498;5412.729363531729;5433.619646624857;5046.823361182341;5149.2276158576515;5198.142306519382;5203.695653260132;5231;5127.41034781005;5168.896622067613;5171.3535808024;5197.480251974772;5247.02929957959;5080.7205603692155;5095.923561146512;5124.846254612367;5141.871453213699;5151.330327057459;5020.523050310215;5179.47205574364;5213.895722085461;5229.686218826882;5259.921101183561;4993.675411098267;5070.5943524517215;5085.389753229488;5090.618203634816;5098.043134981627 05:55:56 INFO - PROCESS | 7058 | |5;yui.html;656.6191608866858;673.7911247513272;725.4269127389362;731.8170457385654;745.7427187620273;12098.153129280954;12726.172798768073;12921.612351629454;13523;13640;12421.503139874416;12591.370431478435;12606.558770443036;12689.809652855214;13489.39297731602;785.4972817396871;811.0389188811248;812.9430939834214;813.0081300812999;814.4339683919649;762.2682225063918;806.2421323955492;811.0389188811278;811.5779794506882;813.7640084375524;849.8045449546609;850.8170743290192;851.6550796927254;852.8848605438279;853.5518852602371;843.3506200225792;844.0209357145743;844.2781421884292;844.3498506150291;844.3962566764762;623.1805176193336;623.7068577768441;623.7068577768487;623.7255607532671;624.6158612453308;12905.935470322682;13089.934550327187;13373.130746501543;13456.93271533646;13460.932695336558;12731.363431828371;13055.869441305655;13086.934565327208;13264.469421223139;13511.729765404636;10513.158947284275;10533.84199237012;10666.520006599721;10739.463026848705;11169.944150279278;3112.8910488133033;3113.066080175961;3266.3140740444537;3281.983590082058;3282.163048422637;60471.69764151195;60762.999999999556;61461.6926915367;62363.20459942507;62544.68727656332;9846.803063938825;10026.348287361445;10037.247206459399;10129;10349.223808214414;17346.739798903025;17887.73168402475;18208.90895545514;19103.713444298348;19127.426177214707;6122.20411346531;6498.447631951242;6617.305182955816;6679.998000299896;6795;3262.217067903686;3322.916927076794;3335.816530090868;3357.8321083945707;3417.7607567470536;3002.894898678536;3043.208765720884;3059.72462478378;3064.1726733782198;3102.5035994241266;526.9104252277122;529.3621186470294;537.2451705353984;538.6875612144946;544.9564034877201;589.2545929399313;593.6823799267371;609.4910749524108;610.2524407600654;616.9327064178996;8063.758087257392;8146.25715193896;8146.877796833052;8473.279771219515;8956.462612243286;506.4378539820796;523.9738013099407;530.098831985626;567.7331654122556;652.4845372155944;3791.260704162662;3866.9806650966566;4174.937375939363;4301.376300436419;4370.890727731832;44883.77558112189;56491.152632710546;57192.142117867435;59681.403185968455;59706.40293597095;34287.31425371528;35447.4682879757;44433.77783111064;49737.502624973284;50289.497105029215;44341.55658443439;45440.09119817519;45673.99999999934;47093.29360059602;47657.28514072292;8298.294644955005;8325.95837020811;8393.454425462325;8422.452540584842;8531.146885311418;33092.83453582717;33109;33623.327533448704;33697.326053479286;33718.831405842815;38787;39503;39875.2024959505;39880.60119398769;41347.793261033505;10813.783724325313;11121.777564448828;11209.103271738404;11259.887401125883;11850.111241657083;12493.125481216228;12548;12623.179493332904;12855.421506032064;12869.935650321688;10839.187060970617;10972.286801357886;11318.151138664469;11337.716557086138;11728;9557.61769529211;10056.19550435978;10345.482725863827;10356.637517686844;10408.583656653953;10675.89324106749;11198.38408887519;11273.887261127284;11274.267172633752;11662.591809286634;9499.715008549754;9761.829215087557;9810.30216690416;9882.357646752938;10030.348027378197;8580.699675511327;8678.123066483065;8696.130386961253;9239.815203696024;9422.670206542738 05:55:56 INFO - PROCESS | 7058 | __end_tp_report 05:55:56 INFO - PROCESS | 7058 | __start_cc_report 05:55:56 INFO - PROCESS | 7058 | _x_x_mozilla_cycle_collect,378 05:55:56 INFO - PROCESS | 7058 | __end_cc_report 05:55:56 INFO - PROCESS | 7058 | __startTimestamp1486475756968__endTimestamp 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | ------- Summary: start ------- 05:55:56 INFO - PROCESS | 7058 | Number of tests: 6 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | [#0] dojo.html Cycles:165 Average:4768.63 Median:4873.61 stddev:495.64 (10.2%) stddev-sans-first:467.35 05:55:56 INFO - PROCESS | 7058 | Values: 2610.6 2612.3 2619.8 2631.1 2668.1 4714.8 4843.3 4855.8 4857.0 4864.1 4739.2 4859.6 4862.9 4864.5 4865.1 4437.2 4453.3 4490.9 4525.8 4542.7 4481.9 4555.1 4558.5 4566.3 4570.6 4341.8 4375.1 4495.4 4503.2 4549.5 4368.0 4404.3 4439.9 4457.0 4470.7 4356.6 4416.7 4426.4 4436.6 4450.5 4601.9 4795.0 4814.8 4818.0 4837.5 5000.8 5067.9 5090.7 5092.1 5121.1 5160.4 5192.0 5195.6 5196.7 5255.5 4846.9 4848.8 4850.3 4856.5 4906.8 5155.7 5174.7 5277.4 5295.1 5297.0 5125.4 5126.5 5136.3 5152.4 5178.0 5032.4 5059.8 5101.2 5112.8 5215.3 5054.5 5107.4 5118.0 5119.1 5156.6 4944.2 5050.4 5120.8 5165.6 5175.9 4460.5 4465.4 4475.5 4496.3 4512.8 3819.7 3827.3 3828.3 3844.0 3878.9 4372.7 4461.5 4471.4 4510.2 4536.5 5151.7 5217.5 5236.4 5265.7 5269.3 4511.5 4515.7 4516.8 4520.3 4564.7 4590.9 4632.2 4699.5 4717.6 4744.1 4840.4 4841.2 4853.5 4887.2 4929.9 5176.8 5178.8 5179.0 5224.3 5300.7 4694.7 4835.9 4843.0 4845.8 4893.0 4959.3 5030.1 5072.0 5085.4 5087.2 5087.2 5154.8 5155.7 5156.8 5159.3 4969.1 4982.7 4997.2 5008.6 5043.2 5013.5 5027.6 5029.9 5042.0 5046.2 4904.3 4926.9 4945.5 4962.1 4965.0 4910.3 4937.5 4948.3 4970.5 5110.8 4835.6 4873.6 4879.2 4880.8 4882.6 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | [#1] ext.html Cycles:180 Average:40751.68 Median:35392.65 stddev:69106.93 (195.3%) stddev-sans-first:69234.68 05:55:56 INFO - PROCESS | 7058 | Values: 491.2 505.9 514.5 521.5 567.4 33802.8 37078.1 37404.8 37542.4 37637.4 37505.6 37973.0 37993.8 38033.4 38046.4 7452.5 7610.2 9090.5 9550.8 9563.7 9260.1 9380.0 9404.4 9424.0 9476.6 9413.2 9491.0 9561.2 9563.3 9579.0 9353.3 9448.4 9486.2 9502.0 9536.7 9360.2 9396.8 9403.3 9428.4 9458.9 33119.7 33318.7 33341.0 33358.0 33360.3 3348.3 3395.2 3460.4 3519.1 3524.4 23402.0 24773.4 24895.1 24920.6 25712.1 3438.6 3470.6 3502.2 3508.4 3517.5 228964.0 233506.0 236362.8 236981.0 237172.0 30498.0 32079.0 32187.7 33455.5 46328.8 32824.0 32825.0 32970.0 32986.8 33096.7 10989.6 11056.7 11126.3 11162.8 11211.0 8646.1 8905.8 8924.2 8949.1 8993.9 7855.8 7868.5 7986.1 8016.0 8096.0 3162.9 3194.0 3200.4 3204.4 3226.9 747.7 763.0 763.7 773.3 777.7 24689.8 26426.3 26461.2 27280.9 27674.2 913.7 920.2 934.2 938.6 1017.6 13515.4 13981.2 14281.8 14610.6 14611.6 323669.0 325031.0 328037.0 328490.0 330393.0 47612.8 48519.0 48535.5 48578.5 48588.3 1155.2 1198.1 1204.0 1211.0 1211.8 24844.4 25334.7 26385.7 26582.7 26749.0 41556.2 42487.0 42584.1 42595.6 42752.6 214848.0 216122.0 216326.0 216331.0 217493.0 24916.0 38565.0 40127.6 40321.8 42176.8 38416.8 38595.4 40098.6 42083.6 42694.8 35714.8 36288.3 36621.3 37394.4 37677.0 35368.0 36293.0 36497.6 36855.8 36971.3 34532.7 34829.7 35335.5 35417.3 35890.5 30195.7 32481.0 33181.3 33187.3 33296.8 24059.2 24689.1 24950.4 25157.0 25200.0 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | [#2] jquery.html Cycles:180 Average:26967.65 Median:472436.50 stddev:77739.07 (16.5%) stddev-sans-first:77931.50 05:55:56 INFO - PROCESS | 7058 | Values: 374.0 375.5 390.7 399.3 414.5 16053.6 17381.0 18195.5 18196.9 18209.4 17191.6 17395.0 17627.0 17814.1 18193.7 5063.2 5278.2 5286.8 5286.9 5292.4 5030.0 5046.2 5155.8 5161.4 5265.6 5093.1 5100.6 5110.0 5127.8 5134.1 4944.4 5109.6 5129.8 5131.2 5135.9 4563.0 4567.2 4582.7 4590.4 4590.6 21086.4 21204.6 21261.3 21400.0 21676.7 2207.6 2255.3 2259.4 2271.2 2350.5 11978.0 12775.9 13241.9 13469.8 13815.7 1665.6 1673.5 1673.6 1704.4 1716.6 74020.0 74986.9 75023.0 76228.0 76479.0 10796.2 10972.5 11028.6 11084.1 11240.3 15234.8 15315.9 15361.6 15370.9 15373.6 7074.3 7113.8 7117.1 7172.1 7246.1 6365.5 6422.6 6596.1 6641.7 6652.7 4347.6 4442.4 4502.8 4621.6 4663.2 1872.1 1917.4 1925.9 1980.6 1993.3 933.9 958.0 962.8 994.5 998.5 16240.5 16623.9 17334.7 17773.0 18035.6 933.8 951.5 954.3 955.3 960.4 9391.2 9722.7 9889.0 9896.0 9942.9 463333.0 468054.0 476819.0 478189.0 478201.0 67422.0 71518.6 80810.6 81342.1 85254.0 901.0 911.7 934.7 936.8 938.8 14778.3 14999.0 15538.9 15722.8 15821.4 36357.3 37310.8 37787.2 37797.7 38745.6 50250.0 50399.0 50585.0 51512.2 53089.7 7189.1 7458.7 7534.9 7566.3 7718.8 8591.1 10785.0 10830.9 10999.7 11169.4 8467.9 8783.1 9418.2 10095.0 10608.4 9308.6 9776.4 9917.4 10636.3 10787.9 10309.4 10364.2 10571.4 10669.4 11140.3 7720.2 7728.2 7768.9 7828.6 7830.6 9603.6 9641.4 9759.2 9920.7 10102.7 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | [#3] mootools.html Cycles:180 Average:4948.98 Median:5129.31 stddev:2735.86 (53.3%) stddev-sans-first:2729.98 05:55:56 INFO - PROCESS | 7058 | Values: 1324.7 1328.2 1339.7 1355.5 1363.6 7170.2 7291.0 7644.3 7669.3 7701.0 7615.1 7915.2 7933.7 7936.1 7939.6 2111.6 2147.0 2154.3 2155.8 2163.4 1843.6 1918.4 2097.3 2106.0 2144.4 2080.8 2131.3 2132.1 2133.2 2140.6 2033.1 2050.6 2051.2 2056.1 2065.5 1931.1 2053.0 2136.3 2137.4 2138.4 7457.3 7536.6 7546.2 7546.5 7559.6 4569.6 4723.9 4731.4 4736.4 4737.5 2860.2 3023.8 3072.4 3085.6 3096.9 1125.2 1184.6 1201.5 1207.1 1209.8 9956.0 9966.5 9995.3 10007.4 10111.5 3785.7 3948.1 4014.1 4019.5 4171.1 8221.3 8309.5 8311.3 8338.2 8343.2 4518.2 4556.2 4589.7 4670.7 4692.1 4113.5 4130.6 4225.5 4229.9 4233.2 3315.9 3347.3 3421.3 3425.5 3446.5 946.9 979.8 1001.7 1026.7 1052.9 658.7 661.2 676.8 819.4 833.7 4960.8 5004.9 5130.8 5262.9 5298.3 846.6 863.3 898.2 900.3 913.6 3423.2 3462.6 3486.6 3549.0 3597.9 9146.1 9419.2 9419.8 9430.4 9438.7 9169.4 9371.3 9374.2 9392.7 9420.0 7022.3 7264.5 7273.9 7276.0 7284.1 4871.6 4976.0 5054.2 5127.8 5138.0 8275.5 8355.9 8422.8 8425.8 8532.1 8523.7 8627.6 8631.4 8657.6 8697.1 6179.8 6289.4 6292.1 6293.4 6297.1 6986.2 7056.9 7102.6 7118.9 7168.3 5754.3 6365.1 6426.0 6470.6 6515.2 6352.7 6353.3 6401.0 6454.0 6473.7 5776.2 5873.2 5877.5 5886.9 5888.8 4379.3 4420.4 4501.5 4504.3 4514.2 4391.7 4437.3 4457.6 4493.0 4521.4 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | [#4] prototype.html Cycles:180 Average:4240.75 Median:4815.18 stddev:1236.96 (25.7%) stddev-sans-first:1205.61 05:55:56 INFO - PROCESS | 7058 | Values: 358.2 362.8 366.9 368.3 377.7 4814.6 4825.3 4842.9 4907.3 4908.0 4745.6 4772.4 4801.1 4900.6 4933.0 3693.7 3727.4 3827.0 3850.2 3874.3 3808.8 3818.8 3869.9 3882.6 3892.9 3782.7 3811.2 3832.7 3856.9 3898.2 3731.5 3796.3 3870.6 3879.5 3883.9 3332.8 3377.6 3380.5 3400.5 3424.7 4801.9 4807.9 4815.8 4822.3 4870.0 4247.6 4364.7 4365.3 4395.6 4430.1 4959.7 5031.4 5135.6 5168.6 5175.4 3638.3 3651.8 3655.4 3668.9 3685.2 5176.0 5200.3 5287.0 5407.7 5488.1 3662.8 3706.5 3719.7 3723.0 3741.1 3744.8 3765.6 3789.6 3807.4 3848.5 4186.5 4328.2 4349.8 4375.6 4378.7 5020.5 5095.5 5104.4 5108.8 5137.5 1188.6 1198.3 1210.5 1222.0 1229.8 840.8 861.8 877.4 878.3 892.3 4248.8 4274.7 4279.5 4284.6 4359.9 5002.9 5063.9 5064.4 5150.6 5157.0 4372.0 4388.2 4404.4 4463.4 4475.4 2526.7 2658.1 2709.5 2728.2 2730.7 4664.8 4726.1 4740.0 4804.6 4888.5 5106.8 5227.3 5266.4 5293.8 5396.3 4892.8 4936.2 4940.2 4974.3 4986.4 5251.4 5335.4 5358.5 5386.2 5390.5 4948.4 5226.3 5232.3 5266.9 5270.9 4737.9 4831.3 4866.6 4981.3 5005.5 3643.5 3697.7 3710.3 3774.7 3804.5 5291.9 5328.4 5349.2 5412.7 5433.6 5046.8 5149.2 5198.1 5203.7 5231.0 5127.4 5168.9 5171.4 5197.5 5247.0 5080.7 5095.9 5124.8 5141.9 5151.3 5020.5 5179.5 5213.9 5229.7 5259.9 4993.7 5070.6 5085.4 5090.6 5098.0 05:55:56 INFO - PROCESS | 7058 | 05:55:56 INFO - PROCESS | 7058 | [#5] yui.html Cycles:180 Average:13587.95 Median:24356.22 stddev:16082.78 (66.0%) stddev-sans-first:16098.58 05:55:56 INFO - PROCESS | 7058 | Values: 656.6 673.8 725.4 731.8 745.7 12098.2 12726.2 12921.6 13523.0 13640.0 12421.5 12591.4 12606.6 12689.8 13489.4 785.5 811.0 812.9 813.0 814.4 762.3 806.2 811.0 811.6 813.8 849.8 850.8 851.7 852.9 853.6 843.4 844.0 844.3 844.3 844.4 623.2 623.7 623.7 623.7 624.6 12905.9 13089.9 13373.1 13456.9 13460.9 12731.4 13055.9 13086.9 13264.5 13511.7 10513.2 10533.8 10666.5 10739.5 11169.9 3112.9 3113.1 3266.3 3282.0 3282.2 60471.7 60763.0 61461.7 62363.2 62544.7 9846.8 10026.3 10037.2 10129.0 10349.2 17346.7 17887.7 18208.9 19103.7 19127.4 6122.2 6498.4 6617.3 6680.0 6795.0 3262.2 3322.9 3335.8 3357.8 3417.8 3002.9 3043.2 3059.7 3064.2 3102.5 526.9 529.4 537.2 538.7 545.0 589.3 593.7 609.5 610.3 616.9 8063.8 8146.3 8146.9 8473.3 8956.5 506.4 524.0 530.1 567.7 652.5 3791.3 3867.0 4174.9 4301.4 4370.9 44883.8 56491.2 57192.1 59681.4 59706.4 34287.3 35447.5 44433.8 49737.5 50289.5 44341.6 45440.1 45674.0 47093.3 47657.3 8298.3 8326.0 8393.5 8422.5 8531.1 33092.8 33109.0 33623.3 33697.3 33718.8 38787.0 39503.0 39875.2 39880.6 41347.8 10813.8 11121.8 11209.1 11259.9 11850.1 12493.1 12548.0 12623.2 12855.4 12869.9 10839.2 10972.3 11318.2 11337.7 11728.0 9557.6 10056.2 10345.5 10356.6 10408.6 10675.9 11198.4 11273.9 11274.3 11662.6 9499.7 9761.8 9810.3 9882.4 10030.3 8580.7 8678.1 8696.1 9239.8 9422.7 05:55:56 INFO - PROCESS | 7058 | -------- Summary: end -------- 05:55:56 INFO - PROCESS | 7058 | 05:55:57 INFO - TEST-INFO | 7058: exit 0 05:55:57 INFO - TEST-OK | dromaeo_css | took 1122753ms 05:55:57 INFO - TEST-START | kraken 05:55:57 INFO - operating with platform_type : linux_ 05:55:57 INFO - Initialising browser for kraken test... 05:55:57 INFO - TEST-INFO | started process 7418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp09BFIA/profile http://localhost:45595/getInfo.html) 05:56:02 INFO - PROCESS | 7418 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:56:02 INFO - PROCESS | 7418 | __metrics Screen width/height:1600/1200 05:56:02 INFO - PROCESS | 7418 | colorDepth:24 05:56:02 INFO - PROCESS | 7418 | Browser inner width/height: 1024/697 05:56:02 INFO - PROCESS | 7418 | __metrics 05:56:03 INFO - PROCESS | 7418 | 1486475763219 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6310:36 < canClose@browser.js:5176:12 < forceQuit@jar:file:///tmp/tmp09BFIA/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp09BFIA/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp09BFIA/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp09BFIA/profile/extensions/talos-powers@TalosPowersService.js:55:9 05:56:03 ERROR - PROCESS | 7418 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:56:04 INFO - TEST-INFO | 7418: exit 0 05:56:04 INFO - Browser initialized. 05:56:04 INFO - Running cycle 1/1 for kraken test... 05:56:04 INFO - TEST-INFO | started process 7535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp09BFIA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:16 INFO - PROCESS | 7535 | RSS: Main: 159404032 05:56:16 INFO - PROCESS | 7535 | 05:56:19 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45595/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:20 INFO - PROCESS | 7535 | RSS: Main: 165797888 05:56:20 INFO - PROCESS | 7535 | 05:56:23 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45595/tests/kraken/driver.html?testName=audio-dft) 05:56:23 INFO - PROCESS | 7535 | RSS: Main: 164425728 05:56:23 INFO - PROCESS | 7535 | 05:56:26 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45595/tests/kraken/driver.html?testName=audio-fft) 05:56:27 INFO - PROCESS | 7535 | RSS: Main: 161865728 05:56:27 INFO - PROCESS | 7535 | 05:56:29 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45595/tests/kraken/driver.html?testName=audio-oscillator) 05:56:30 INFO - PROCESS | 7535 | RSS: Main: 162693120 05:56:30 INFO - PROCESS | 7535 | 05:56:32 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:33 INFO - PROCESS | 7535 | RSS: Main: 162492416 05:56:33 INFO - PROCESS | 7535 | 05:56:36 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45595/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:36 INFO - PROCESS | 7535 | RSS: Main: 167583744 05:56:36 INFO - PROCESS | 7535 | 05:56:40 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45595/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:41 INFO - PROCESS | 7535 | RSS: Main: 164270080 05:56:41 INFO - PROCESS | 7535 | 05:56:44 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45595/tests/kraken/driver.html?testName=json-parse-financial) 05:56:44 INFO - PROCESS | 7535 | RSS: Main: 165720064 05:56:44 INFO - PROCESS | 7535 | 05:56:46 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:47 INFO - PROCESS | 7535 | RSS: Main: 165498880 05:56:47 INFO - PROCESS | 7535 | 05:56:48 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:49 INFO - PROCESS | 7535 | RSS: Main: 165015552 05:56:49 INFO - PROCESS | 7535 | 05:56:51 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:52 INFO - PROCESS | 7535 | RSS: Main: 165466112 05:56:52 INFO - PROCESS | 7535 | 05:56:55 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:56 INFO - PROCESS | 7535 | RSS: Main: 166211584 05:56:56 INFO - PROCESS | 7535 | 05:56:59 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:59 INFO - PROCESS | 7535 | RSS: Main: 168873984 05:56:59 INFO - PROCESS | 7535 | 05:57:01 INFO - PROCESS | 7535 | Cycle 1(1): loaded http://localhost:45595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45595/tests/kraken/driver.html?testName=ai-astar) 05:57:02 INFO - PROCESS | 7535 | RSS: Main: 171683840 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | __start_tp_report 05:57:02 INFO - PROCESS | 7535 | _x_x_mozilla_page_load 05:57:02 INFO - PROCESS | 7535 | _x_x_mozilla_page_load_details 05:57:02 INFO - PROCESS | 7535 | |i|pagename|runs| 05:57:02 INFO - PROCESS | 7535 | |0;ai-astar;112;115;115;117;114;114;115;116;116;114 05:57:02 INFO - PROCESS | 7535 | |1;audio-beat-detection;159;130;134;183;128;137;136;127;159;128 05:57:02 INFO - PROCESS | 7535 | |2;audio-dft;166;172;171;164;171;170;164;173;164;164 05:57:02 INFO - PROCESS | 7535 | |3;audio-fft;77;76;77;108;77;79;77;79;95;78 05:57:02 INFO - PROCESS | 7535 | |4;audio-oscillator;85;85;111;91;86;91;102;85;84;111 05:57:02 INFO - PROCESS | 7535 | |5;imaging-gaussian-blur;125;118;119;124;126;117;120;118;118;119 05:57:02 INFO - PROCESS | 7535 | |6;imaging-darkroom;152;156;150;150;151;151;151;152;149;152 05:57:02 INFO - PROCESS | 7535 | |7;imaging-desaturate;95;101;96;96;96;97;107;96;96;97 05:57:02 INFO - PROCESS | 7535 | |8;json-parse-financial;65;66;65;67;66;67;72;67;69;66 05:57:02 INFO - PROCESS | 7535 | |9;json-stringify-tinderbox;66;67;66;67;66;68;67;66;81;67 05:57:02 INFO - PROCESS | 7535 | |10;stanford-crypto-aes;98;98;90;89;98;90;97;89;98;101 05:57:02 INFO - PROCESS | 7535 | |11;stanford-crypto-ccm;156;154;141;138;140;155;135;145;188;146 05:57:02 INFO - PROCESS | 7535 | |12;stanford-crypto-pbkdf2;193;181;179;182;183;196;195;179;190;180 05:57:02 INFO - PROCESS | 7535 | |13;stanford-crypto-sha256-iterative;76;79;72;78;76;69;69;71;87;75 05:57:02 INFO - PROCESS | 7535 | __end_tp_report 05:57:02 INFO - PROCESS | 7535 | __start_cc_report 05:57:02 INFO - PROCESS | 7535 | _x_x_mozilla_cycle_collect,878 05:57:02 INFO - PROCESS | 7535 | __end_cc_report 05:57:02 INFO - PROCESS | 7535 | __startTimestamp1486475822129__endTimestamp 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | ------- Summary: start ------- 05:57:02 INFO - PROCESS | 7535 | Number of tests: 14 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:1.05 05:57:02 INFO - PROCESS | 7535 | Values: 112.0 115.0 115.0 117.0 114.0 114.0 115.0 116.0 116.0 114.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:136.50 stddev:18.69 (13.7%) stddev-sans-first:18.80 05:57:02 INFO - PROCESS | 7535 | Values: 159.0 130.0 134.0 183.0 128.0 137.0 136.0 127.0 159.0 128.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#2] audio-dft Cycles:10 Average:167.90 Median:170.50 stddev:3.81 (2.2%) stddev-sans-first:3.98 05:57:02 INFO - PROCESS | 7535 | Values: 166.0 172.0 171.0 164.0 171.0 170.0 164.0 173.0 164.0 164.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.50 stddev:10.61 (13.7%) stddev-sans-first:11.08 05:57:02 INFO - PROCESS | 7535 | Values: 77.0 76.0 77.0 108.0 77.0 79.0 77.0 79.0 95.0 78.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:85.00 stddev:10.85 (12.8%) stddev-sans-first:11.10 05:57:02 INFO - PROCESS | 7535 | Values: 85.0 85.0 111.0 91.0 86.0 91.0 102.0 85.0 84.0 111.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#5] imaging-gaussian-blur Cycles:10 Average:120.40 Median:119.50 stddev:3.31 (2.8%) stddev-sans-first:3.06 05:57:02 INFO - PROCESS | 7535 | Values: 125.0 118.0 119.0 124.0 126.0 117.0 120.0 118.0 118.0 119.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:1.90 (1.3%) stddev-sans-first:2.00 05:57:02 INFO - PROCESS | 7535 | Values: 152.0 156.0 150.0 150.0 151.0 151.0 151.0 152.0 149.0 152.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:96.00 stddev:3.65 (3.8%) stddev-sans-first:3.74 05:57:02 INFO - PROCESS | 7535 | Values: 95.0 101.0 96.0 96.0 96.0 97.0 107.0 96.0 96.0 97.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.00 stddev:2.11 (3.1%) stddev-sans-first:2.11 05:57:02 INFO - PROCESS | 7535 | Values: 65.0 66.0 65.0 67.0 66.0 67.0 72.0 67.0 69.0 66.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:67.00 stddev:4.58 (6.8%) stddev-sans-first:4.80 05:57:02 INFO - PROCESS | 7535 | Values: 66.0 67.0 66.0 67.0 66.0 68.0 67.0 66.0 81.0 67.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:97.50 stddev:4.69 (4.8%) stddev-sans-first:4.82 05:57:02 INFO - PROCESS | 7535 | Values: 98.0 98.0 90.0 89.0 98.0 90.0 97.0 89.0 98.0 101.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:150.00 stddev:15.32 (10.2%) stddev-sans-first:16.08 05:57:02 INFO - PROCESS | 7535 | Values: 156.0 154.0 141.0 138.0 140.0 155.0 135.0 145.0 188.0 146.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:186.50 stddev:6.91 (3.7%) stddev-sans-first:6.82 05:57:02 INFO - PROCESS | 7535 | Values: 193.0 181.0 179.0 182.0 183.0 196.0 195.0 179.0 190.0 180.0 05:57:02 INFO - PROCESS | 7535 | 05:57:02 INFO - PROCESS | 7535 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:76.00 stddev:5.45 (7.2%) stddev-sans-first:5.78 05:57:02 INFO - PROCESS | 7535 | Values: 76.0 79.0 72.0 78.0 76.0 69.0 69.0 71.0 87.0 75.0 05:57:02 INFO - PROCESS | 7535 | -------- Summary: end -------- 05:57:02 INFO - PROCESS | 7535 | 05:57:03 INFO - TEST-INFO | 7535: exit 0 05:57:03 INFO - TEST-OK | kraken | took 65482ms 05:57:03 INFO - SUITE-END | took 1188s 05:57:03 INFO - Completed test suite (00:19:48) 05:57:03 INFO - javascript benchmark 05:57:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6261.382883244713, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.634511168437, 2612.294680436281, 2619.816612837101, 2631.065971580089, 2668.0661768381055, 4714.834980775673, 4843.273508973652, 4855.781489832962, 4857.028594281149, 4864.07582559314, 4739.194336962716, 4859.562639362457, 4862.927056094161, 4864.513548645134, 4865.124277630034, 4437.2234858899565, 4453.3097369907555, 4490.865274041767, 4525.796339164745, 4542.727436353813, 4481.887952801173, 4555.134524440362, 4558.5213552577, 4566.337881007252, 4570.588647021767, 4341.848035318749, 4375.059362237134, 4495.415595972535, 4503.166914120898, 4549.47681016684, 4368.0, 4404.2512772828695, 4439.866803995886, 4457.0194557197365, 4470.709403888769, 4356.607905288539, 4416.734995900256, 4426.3581780641625, 4436.622887054572, 4450.532694067108, 4601.907961840778, 4795.040991801654, 4814.759262036884, 4817.951820481785, 4837.467878533358, 5000.849974500771, 5067.873303167414, 5090.669106508065, 5092.10888094582, 5121.103806833789, 5160.40655324635, 5192.0, 5195.636305458619, 5196.740162991835, 5255.527002569749, 4846.854594362175, 4848.757562121915, 4850.296706977469, 4856.514348565186, 4906.779194936236, 5155.664881782672, 5174.663646862942, 5277.419483856773, 5295.099833028395, 5297.0, 5125.410577783528, 5126.53861152498, 5136.280920671109, 5152.355955505562, 5177.974110129425, 5032.421271553745, 5059.797608095709, 5101.158308879068, 5112.821051263188, 5215.348081489814, 5054.519820617109, 5107.387113546398, 5118.0, 5119.0529751996, 5156.613254005964, 4944.184209605375, 5050.393952725696, 5120.7951681933055, 5165.586753059746, 5175.922361164586, 4460.464744230713, 4465.441819772528, 4475.485319188335, 4496.325551167286, 4512.81948722054, 3819.6944244460933, 3827.2919509890758, 3828.3300422425964, 3844.019774957368, 3878.941815872764, 4372.737635741865, 4461.5092339842595, 4471.441069866267, 4510.1656193604285, 4536.455625324916, 5151.6908985461, 5217.530422261939, 5236.397814251333, 5265.7103859287345, 5269.314989051475, 4511.481179664315, 4515.706479078849, 4516.751578663139, 4520.321951707205, 4564.657650676212, 4590.862274131781, 4632.189366860718, 4699.459562150397, 4717.646176536773, 4744.122337367598, 4840.419149702058, 4841.2496063110275, 4853.49038350968, 4887.242477416006, 4929.852104436873, 5176.792928282826, 5178.792848286026, 5179.0, 5224.2947202127225, 5300.655457395257, 4694.694844835075, 4835.903281934412, 4843.0, 4845.781939812788, 4892.975535122301, 4959.256111583291, 5030.0694371541385, 5072.010957863181, 5085.389753229636, 5087.23691446286, 5087.23691446286, 5154.7938082477785, 5155.7164355959285, 5156.793728250978, 5159.277701121771, 4969.0807200668, 4982.6512144149565, 4997.225430058346, 5008.6243531734535, 5043.218301163325, 5013.523715247045, 5027.572656324253, 5029.924551131663, 5041.974790126026, 5046.1673823818655, 4904.288878112725, 4926.876828079184, 4945.455999839943, 4962.082014827269, 4964.950350496449, 4910.288008238714, 4937.456879743154, 4948.307236986752, 4970.527799859007, 5110.846674599619, 4835.564799167951, 4873.610111191168, 4879.219324907997, 4880.755962201947, 4882.633802464758], "value": 4736.472915437652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.2434850330491, 505.8887044850134, 514.4778050278966, 521.4524749013535, 567.4212303450483, 33802.83098584507, 37078.07304817378, 37404.81297593515, 37542.436863447, 37637.43543846845, 37505.62494375062, 37973.0, 37993.81003094988, 38033.42949855755, 38046.42930356047, 7452.515586486875, 7610.200928902441, 9090.454572725657, 9550.80898382032, 9563.713088607354, 9260.073992600719, 9379.953100234488, 9404.38871473352, 9424.0, 9476.573554190078, 9413.199878010377, 9491.0, 9561.235101191887, 9563.330566860323, 9579.042095790435, 9353.345265831394, 9448.385854919443, 9486.245044666759, 9501.952490237574, 9536.666216682383, 9360.204382627417, 9396.812063758754, 9403.341766076377, 9428.434293942386, 9458.90541094594, 33119.6688033119, 33318.66681333204, 33341.0, 33358.0, 33360.332793343994, 3348.3470723208984, 3395.168183794986, 3460.3598334308235, 3519.1026288296575, 3524.365614189445, 23402.0, 24773.380665483328, 24895.128670496444, 24920.626190607156, 25712.100076497234, 3438.621751607321, 3470.6182319944787, 3502.247016891355, 3508.3684936711384, 3517.4723791431234, 228964.0, 233506.0, 236362.81818590968, 236981.0, 237172.0, 30498.0, 32079.0, 32187.67812321847, 33455.498167527505, 46328.768356158675, 32824.0, 32825.0, 32970.0, 32986.83506582452, 33096.66903330984, 10989.560417583367, 11056.668299951014, 11126.276792008493, 11162.832557511643, 11211.047060999743, 8646.054637706466, 8905.821883562423, 8924.241439477717, 8949.149830766068, 8993.910060899307, 7855.842883142305, 7868.527888326718, 7986.0816006158875, 8015.959920200478, 8095.959520202361, 3162.905112846618, 3194.0, 3200.4079245339685, 3204.439223135942, 3226.870925162967, 747.7009196321407, 762.9961850190714, 763.6678045050421, 773.2963003666637, 777.7316825695126, 24689.753102469105, 26426.339341516617, 26461.221571735077, 27280.863595681894, 27674.169774906786, 913.7487191022522, 920.2362039507193, 934.1592566690033, 938.5635679409107, 1017.577705252312, 13515.391807368693, 13981.23103229332, 14281.78577321341, 14610.561683149523, 14611.634709132144, 323669.0, 325031.0, 328037.0, 328490.0, 330393.0, 47612.761936190094, 48519.0, 48535.51464485381, 48578.51421485811, 48588.27117593239, 1155.231770872394, 1198.0774803401507, 1204.0488014468647, 1211.0493262788668, 1211.7515909238584, 24844.37889052788, 25334.74665253324, 26385.73614263833, 26582.7341726588, 26749.0, 41556.16887662169, 42487.0, 42584.14831703411, 42595.57404425916, 42752.57247427486, 214848.0, 216122.0, 216326.0, 216331.0, 217493.0, 24916.0033598654, 38565.0, 40127.59872401239, 40321.798391007855, 42176.78911605422, 38416.80791596136, 38595.421068684554, 40098.59901400949, 42083.579164207964, 42694.78652606717, 35714.821425892704, 36288.27423451569, 36621.26757464889, 37394.43908341431, 37677.0, 35368.0, 36293.0, 36497.635023649425, 36855.8157209223, 36971.26057478889, 34532.65467345395, 34829.65170348366, 35335.46996794999, 35417.29165416729, 35890.46164307485, 30195.69804301929, 32481.0, 33181.33637327288, 33187.33625327432, 33296.836800503916, 24059.157929472385, 24689.135880244106, 24950.37624059413, 25157.0, 25200.0], "value": 16023.924023410063, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.9738218324715, 375.4968342421156, 390.6894019254693, 399.2753153027257, 414.5046669230269, 16053.58186367791, 17381.0, 18195.545111372205, 18196.909015454905, 18209.362672306474, 17191.570210744736, 17395.0, 17627.0, 17814.109294535287, 18193.7270940936, 5063.164577844651, 5278.2082687596785, 5286.7885284588765, 5286.947130528703, 5292.364916210041, 5030.0, 5046.167382381903, 5155.793768249266, 5161.406438259611, 5265.552428043621, 5093.057784309896, 5100.566451851579, 5110.029094472057, 5127.7948882044675, 5134.0758663440565, 4944.35723355965, 5109.642325037249, 5129.820456284012, 5131.153359695664, 5135.897282054338, 4563.018950925567, 4567.200739870509, 4582.656300777455, 4590.357349971006, 4590.563896429834, 21086.367408977756, 21204.575908481896, 21261.255856045118, 21400.0, 21676.674849877265, 2207.6136676081624, 2255.2670382125875, 2259.401258666455, 2271.216430331533, 2350.4593943392942, 11978.041756659533, 12775.872241277653, 13241.867581324159, 13469.797953030713, 13815.723685526335, 1665.5919299771513, 1673.5397765614432, 1673.6485338078896, 1704.411977867646, 1716.5708572856786, 74020.0, 74986.87519687155, 75023.0, 76227.99999999945, 76479.0, 10796.190285728602, 10972.451377431096, 11028.613998510014, 11084.113270938306, 11240.325580465198, 15234.847651523343, 15315.92342038305, 15361.615959600877, 15370.923145384426, 15373.615659608598, 7074.347011715145, 7113.75101871432, 7117.110361204849, 7172.103487064117, 7246.094238220223, 6365.49076073913, 6422.582532135396, 6596.076549283008, 6641.734330626818, 6652.667366631746, 4347.608715215582, 4442.422485076984, 4502.797374118172, 4621.60716339115, 4663.230566956482, 1872.1107473949764, 1917.4439412570478, 1925.913333899978, 1980.6434841728628, 1993.3023441795256, 933.9159475647224, 957.9904200958041, 962.7978124593914, 994.5275993902839, 998.4907697074544, 16240.51278461648, 16623.91688041552, 17334.739978900325, 17773.0, 18035.63928721418, 933.7852293972288, 951.509972364233, 954.2890546542732, 955.302629080761, 960.3565611040619, 9391.248700103975, 9722.708318750449, 9888.950555247322, 9896.0, 9942.850857237147, 463333.0, 468054.0, 476819.0, 478189.0, 478201.0, 67422.0, 71518.64240678867, 80810.59594702107, 81342.11947283182, 85254.0, 900.9549522523979, 911.6809116809063, 934.7149119518476, 936.798588303518, 938.7887725261761, 14778.261086945824, 14999.025063370846, 15538.922305388402, 15722.764158537402, 15821.446249381217, 36357.27285454223, 37310.81344593368, 37787.24425511529, 37797.67708130202, 38745.6125438742, 50250.0, 50399.0, 50585.0, 51512.22731658953, 53089.734551327, 7189.137303523401, 7458.694728422396, 7534.886976695244, 7566.281203285899, 7718.768436946901, 8591.097934717014, 10785.0, 10830.945845270724, 10999.670009899715, 11169.441527923735, 8467.915320846712, 8783.12168783142, 9418.199453046567, 10095.0, 10608.416537090534, 9308.627654893728, 9776.364536305402, 9917.404955702681, 10636.255462117577, 10787.892121078688, 10309.381437113798, 10364.222683298633, 10571.418571978615, 10669.35983840972, 11140.331580104896, 7720.189380115007, 7728.22250882289, 7768.92231077682, 7828.569428681477, 7830.608469576612, 9603.615855365708, 9641.42151470914, 9759.219262458844, 9920.652777152765, 10102.725188895527], "value": 8419.037410183528, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.6886981559326, 1328.2229895511132, 1339.7454483648105, 1355.4984655677401, 1363.5841068474117, 7170.211276759553, 7290.963545182267, 7644.312011918926, 7669.309762121408, 7701.037370328716, 7615.086189657235, 7915.248051435119, 7933.682652693899, 7936.127026027132, 7939.642716077776, 2111.556573119643, 2146.9892650536726, 2154.3213887625425, 2155.795199456049, 2163.4266919266406, 1843.5667618109733, 1918.3669389101563, 2097.255474306622, 2106.0, 2144.4210063282903, 2080.843936704746, 2131.3392848217027, 2132.136484723682, 2133.157402825883, 2140.550484398278, 2033.1164344406918, 2050.6411378008866, 2051.200031987526, 2056.0953180600486, 2065.473304307407, 1931.121339790392, 2052.9692054619045, 2136.2629892686996, 2137.4122116417952, 2138.422625891016, 7457.254274572553, 7536.585487798169, 7546.169921308651, 7546.50947688404, 7559.622018899088, 4569.588737013684, 4723.858284251478, 4731.384919960383, 4736.431628204603, 4737.502562230985, 2860.184847318525, 3023.833689147096, 3072.3701641163507, 3085.5988721466065, 3096.8606412711483, 1125.1786196076828, 1184.6150001249628, 1201.5013769285824, 1207.0705556721364, 1209.7580483903255, 9955.950220248853, 9966.451845148515, 9995.250356223312, 10007.399556026661, 10111.49442527878, 3785.6782173515007, 3948.0919388540797, 4014.116894283253, 4019.517657881073, 4171.10321280926, 8221.301189398848, 8309.45988510757, 8311.25198732117, 8338.24955753973, 8343.207395297437, 4518.209313370147, 4556.202664533694, 4589.701669391479, 4670.696404733681, 4692.061587682477, 4113.547509773923, 4130.648894843972, 4225.535191128974, 4229.936550951738, 4233.1956928183545, 3315.8839440619463, 3347.3305338931823, 3421.3157368526395, 3425.469052296848, 3446.5174875517446, 946.8769060022153, 979.8236317462782, 1001.6944831826363, 1026.712520494263, 1052.9417934975454, 658.6937074260492, 661.2329697550817, 676.8003987042113, 819.4059307002494, 833.6582001379405, 4960.751962401865, 5004.9499505005215, 5130.846074617767, 5262.92105618416, 5298.284731561267, 846.5513277962566, 863.3179787967435, 898.1961144775389, 900.293269783217, 913.6345461815328, 3423.2297733009873, 3462.6364231755806, 3486.633903440153, 3548.964510354915, 3597.869853227656, 9146.131117543822, 9419.24646028316, 9419.764505887408, 9430.387024843363, 9438.716838494856, 9169.40398874071, 9371.250299975985, 9374.203192728695, 9392.671256506126, 9419.952900235456, 7022.262662420474, 7264.527805692507, 7273.89089163663, 7276.0, 7284.053073100569, 4871.561559459524, 4975.997367935604, 5054.194921818426, 5127.769250383816, 5137.974310128426, 8275.50346979183, 8355.874661879956, 8422.789430264293, 8425.789355266168, 8532.104129066607, 8523.74428767138, 8627.611757470804, 8631.352648551258, 8657.567121643766, 8697.08680588529, 6179.81460556184, 6289.40250676185, 6292.087647291209, 6293.37066293367, 6297.118403423616, 6986.196587392515, 7056.929430705627, 7102.609356485443, 7118.928810711826, 7168.319009694071, 5754.309482862083, 6365.077063825812, 6426.0, 6470.579412338371, 6515.218173819172, 6352.68236588178, 6353.3011368748475, 6400.967995159995, 6454.0, 6473.741050357933, 5776.162456443708, 5873.207117039145, 5877.471027607536, 5886.911696324473, 5888.793892213924, 4379.255526560556, 4420.403245561936, 4501.459824820911, 4504.324351347193, 4514.232580461264, 4391.692581519263, 4437.312216606431, 4457.576530229623, 4492.9775351123035, 4521.434820647419], "value": 4002.527844650887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.1744079895839, 362.7660159197318, 366.90277076574694, 368.2763369977994, 377.73369774309134, 4814.603764908177, 4825.324454576357, 4842.8547143585665, 4907.337509436234, 4908.0, 4745.57289843914, 4772.403449568804, 4801.079568172724, 4900.583450406711, 4933.013397320532, 3693.722970777189, 3727.4036154215332, 3826.961730382702, 3850.24920140572, 3874.2638898609316, 3808.8095595220266, 3818.847246110166, 3869.922601547967, 3882.5833266725244, 3892.8832135035996, 3782.7352085354037, 3811.1805961718223, 3832.6550610445056, 3856.8842934712, 3898.2203559288114, 3731.477593136963, 3796.316663000659, 3870.593587673296, 3879.4568760373572, 3883.864064757734, 3332.750043746729, 3377.5681509313254, 3380.4956794226578, 3400.500632035452, 3424.6746559076846, 4801.895564020295, 4807.879803004917, 4815.759212039384, 4822.348982887301, 4869.975650121763, 4247.5964783345535, 4364.650827933758, 4365.323374876899, 4395.626371758372, 4430.136123455927, 4959.652234741571, 5031.421386540558, 5135.64050516464, 5168.612354073422, 5175.353080864892, 3638.308721342936, 3651.8454112074005, 3655.4334078217917, 3668.853245870162, 3685.2261025184744, 5176.0, 5200.29795977542, 5287.0, 5407.675539467645, 5488.1493368527945, 3662.8278950735507, 3706.462562928414, 3719.7210209234418, 3723.0, 3741.110739076749, 3744.756590821588, 3765.585785563586, 3789.6020917803785, 3807.3908174691915, 3848.5189351331082, 4186.451013125164, 4328.156009578165, 4349.847755328548, 4375.649948004152, 4378.7372757634, 5020.523050310215, 5095.541401273903, 5104.412992505835, 5108.846734597968, 5137.51193636604, 1188.6434069779032, 1198.2570806100273, 1210.5352523446727, 1221.9511219551296, 1229.766344394562, 840.848647243502, 861.7759382560454, 877.368294827723, 878.3017501086651, 892.3485855325648, 4248.766317852548, 4274.6962176535835, 4279.507856596531, 4284.564670835242, 4359.912801743947, 5002.924956125661, 5063.949360506422, 5064.366529404689, 5150.562202212779, 5157.0, 4371.978140109279, 4388.188185185751, 4404.436425069054, 4463.419755431838, 4475.397305169305, 2526.7220605733355, 2658.122819469609, 2709.4851978124093, 2728.2224565998595, 2730.699623041464, 4664.790084446208, 4726.109556177556, 4739.9763001185465, 4804.591609713144, 4888.5111488850835, 5106.795728170831, 5227.3465816772905, 5266.368035835724, 5293.8411847643865, 5396.325459317585, 4892.828750993769, 4936.210206367035, 4940.2342636891335, 4974.253861920669, 4986.376702912136, 5251.36983561975, 5335.386430560535, 5358.46415358461, 5386.192071189353, 5390.4879036491475, 4948.430930443045, 5226.27532914145, 5232.2936403586555, 5266.947330526646, 5270.920936186037, 4737.857864264078, 4831.323614694016, 4866.610671146229, 4981.277714731416, 5005.499450054966, 3643.5081264030077, 3697.7041836652465, 3710.332140214787, 3774.698024158116, 3804.505414296124, 5291.930680205549, 5328.387235467971, 5349.224362467498, 5412.729363531729, 5433.619646624857, 5046.823361182341, 5149.2276158576515, 5198.142306519382, 5203.695653260132, 5231.0, 5127.41034781005, 5168.896622067613, 5171.3535808024, 5197.480251974772, 5247.02929957959, 5080.7205603692155, 5095.923561146512, 5124.846254612367, 5141.871453213699, 5151.330327057459, 5020.523050310215, 5179.47205574364, 5213.895722085461, 5229.686218826882, 5259.921101183561, 4993.675411098267, 5070.5943524517215, 5085.389753229488, 5090.618203634816, 5098.043134981627], "value": 3861.413173354644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.6191608866858, 673.7911247513272, 725.4269127389362, 731.8170457385654, 745.7427187620273, 12098.153129280954, 12726.172798768073, 12921.612351629454, 13523.0, 13640.0, 12421.503139874416, 12591.370431478435, 12606.558770443036, 12689.809652855214, 13489.39297731602, 785.4972817396871, 811.0389188811248, 812.9430939834214, 813.0081300812999, 814.4339683919649, 762.2682225063918, 806.2421323955492, 811.0389188811278, 811.5779794506882, 813.7640084375524, 849.8045449546609, 850.8170743290192, 851.6550796927254, 852.8848605438279, 853.5518852602371, 843.3506200225792, 844.0209357145743, 844.2781421884292, 844.3498506150291, 844.3962566764762, 623.1805176193336, 623.7068577768441, 623.7068577768487, 623.7255607532671, 624.6158612453308, 12905.935470322682, 13089.934550327187, 13373.130746501543, 13456.93271533646, 13460.932695336558, 12731.363431828371, 13055.869441305655, 13086.934565327208, 13264.469421223139, 13511.729765404636, 10513.158947284275, 10533.84199237012, 10666.520006599721, 10739.463026848705, 11169.944150279278, 3112.8910488133033, 3113.066080175961, 3266.3140740444537, 3281.983590082058, 3282.163048422637, 60471.69764151195, 60762.999999999556, 61461.6926915367, 62363.20459942507, 62544.68727656332, 9846.803063938825, 10026.348287361445, 10037.247206459399, 10129.0, 10349.223808214414, 17346.739798903025, 17887.73168402475, 18208.90895545514, 19103.713444298348, 19127.426177214707, 6122.20411346531, 6498.447631951242, 6617.305182955816, 6679.998000299896, 6795.0, 3262.217067903686, 3322.916927076794, 3335.816530090868, 3357.8321083945707, 3417.7607567470536, 3002.894898678536, 3043.208765720884, 3059.72462478378, 3064.1726733782198, 3102.5035994241266, 526.9104252277122, 529.3621186470294, 537.2451705353984, 538.6875612144946, 544.9564034877201, 589.2545929399313, 593.6823799267371, 609.4910749524108, 610.2524407600654, 616.9327064178996, 8063.758087257392, 8146.25715193896, 8146.877796833052, 8473.279771219515, 8956.462612243286, 506.4378539820796, 523.9738013099407, 530.098831985626, 567.7331654122556, 652.4845372155944, 3791.260704162662, 3866.9806650966566, 4174.937375939363, 4301.376300436419, 4370.890727731832, 44883.77558112189, 56491.152632710546, 57192.142117867435, 59681.403185968455, 59706.40293597095, 34287.31425371528, 35447.4682879757, 44433.77783111064, 49737.502624973284, 50289.497105029215, 44341.55658443439, 45440.09119817519, 45673.99999999934, 47093.29360059602, 47657.28514072292, 8298.294644955005, 8325.95837020811, 8393.454425462325, 8422.452540584842, 8531.146885311418, 33092.83453582717, 33109.0, 33623.327533448704, 33697.326053479286, 33718.831405842815, 38787.0, 39503.0, 39875.2024959505, 39880.60119398769, 41347.793261033505, 10813.783724325313, 11121.777564448828, 11209.103271738404, 11259.887401125883, 11850.111241657083, 12493.125481216228, 12548.0, 12623.179493332904, 12855.421506032064, 12869.935650321688, 10839.187060970617, 10972.286801357886, 11318.151138664469, 11337.716557086138, 11728.0, 9557.61769529211, 10056.19550435978, 10345.482725863827, 10356.637517686844, 10408.583656653953, 10675.89324106749, 11198.38408887519, 11273.887261127284, 11274.267172633752, 11662.591809286634, 9499.715008549754, 9761.829215087557, 9810.30216690416, 9882.357646752938, 10030.348027378197, 8580.699675511327, 8678.123066483065, 8696.130386961253, 9239.815203696024, 9422.670206542738], "value": 6101.100812148065, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1610.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 117.0, 114.0, 114.0, 115.0, 116.0, 116.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 134.0, 183.0, 128.0, 137.0, 136.0, 127.0, 159.0, 128.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 171.0, 164.0, 171.0, 170.0, 164.0, 173.0, 164.0, 164.0], "value": 167.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 108.0, 77.0, 79.0, 77.0, 79.0, 95.0, 78.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 111.0, 91.0, 86.0, 91.0, 102.0, 85.0, 84.0, 111.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 118.0, 119.0, 124.0, 126.0, 117.0, 120.0, 118.0, 118.0, 119.0], "value": 120.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 156.0, 150.0, 150.0, 151.0, 151.0, 151.0, 152.0, 149.0, 152.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 96.0, 96.0, 96.0, 97.0, 107.0, 96.0, 96.0, 97.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 67.0, 66.0, 67.0, 72.0, 67.0, 69.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 68.0, 67.0, 66.0, 81.0, 67.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 90.0, 89.0, 98.0, 90.0, 97.0, 89.0, 98.0, 101.0], "value": 94.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 141.0, 138.0, 140.0, 155.0, 135.0, 145.0, 188.0, 146.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 181.0, 179.0, 182.0, 183.0, 196.0, 195.0, 179.0, 190.0, 180.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 72.0, 78.0, 76.0, 69.0, 69.0, 71.0, 87.0, 75.0], "value": 75.2, "unit": "score"}]}]} 05:57:03 INFO - Return code: 0 05:57:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:57:03 ERROR - # TBPL SUCCESS # 05:57:03 INFO - Running post-action listener: _resource_record_post_action 05:57:03 INFO - [mozharness: 2017-02-07 13:57:03.927823Z] Finished run-tests step (success) 05:57:03 INFO - Running post-run listener: _resource_record_post_run 05:57:03 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407191552; Read time: 12; Write time: 332224 05:57:03 INFO - TinderboxPrint: CPU usage
13.5% 05:57:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:57:03 INFO - TinderboxPrint: I/O write bytes / time
407,191,552 / 332,224 05:57:03 INFO - TinderboxPrint: CPU idle
8,320.7 (86.5%) 05:57:03 INFO - TinderboxPrint: CPU user
1,233.4 (12.8%) 05:57:03 INFO - TinderboxPrint: Swap in / out
0 / 0 05:57:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99815424; Read time: 0; Write time: 106496 05:57:04 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 295145472; Read time: 0; Write time: 222872 05:57:04 INFO - Running post-run listener: _upload_blobber_files 05:57:04 INFO - Blob upload gear active. 05:57:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:57:04 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 05:57:04 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:57:04 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:57:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:57:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:08 INFO - (blobuploader) - INFO - Done attempting. 05:57:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:57:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:57:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:09 INFO - (blobuploader) - INFO - Done attempting. 05:57:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:57:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:57:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:10 INFO - (blobuploader) - INFO - Done attempting. 05:57:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:57:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:57:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:11 INFO - (blobuploader) - INFO - Done attempting. 05:57:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:57:11 INFO - Return code: 0 05:57:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:57:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:57:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dfaaeab478c84d907092b60a6945cccb5fbb7e3b192820a61308aaf97b9caa7d1c19d28560ff52b946edfe2a0a666923ed28147ad56f12a12b84e12ecc31d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf87edd2e2334e4f389f8923930ce78d421ae35c13f4b7e5b9a756e454e499434d1938ae9f0ac3fdfd85624cc29bf009b2c77c4b2c2616e77598423a8dc5f8a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d336bbcfb9b6d57033d9de6d27766d8f2fdd86582d9c0fd47b90b6baa3dceaac082a295fd3dd7f196a4efeee2f241817892ca1a70d5ba368fd3b34dd312508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f0c371306d367fefd110c5da6616b31331b4d4f60eb96342e399b03861d3bc869a4e27426e463591b79be9ea5f0f371ca5d903f819d2aa5ab12a7acf29a7a0"} 05:57:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:57:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:57:11 INFO - Contents: 05:57:11 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dfaaeab478c84d907092b60a6945cccb5fbb7e3b192820a61308aaf97b9caa7d1c19d28560ff52b946edfe2a0a666923ed28147ad56f12a12b84e12ecc31d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf87edd2e2334e4f389f8923930ce78d421ae35c13f4b7e5b9a756e454e499434d1938ae9f0ac3fdfd85624cc29bf009b2c77c4b2c2616e77598423a8dc5f8a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d336bbcfb9b6d57033d9de6d27766d8f2fdd86582d9c0fd47b90b6baa3dceaac082a295fd3dd7f196a4efeee2f241817892ca1a70d5ba368fd3b34dd312508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f0c371306d367fefd110c5da6616b31331b4d4f60eb96342e399b03861d3bc869a4e27426e463591b79be9ea5f0f371ca5d903f819d2aa5ab12a7acf29a7a0"} 05:57:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:57:11 INFO - Copying logs to upload dir... 05:57:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:57:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.194386 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-02-07 05:57:10.798456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 05:57:10.801964) ========= 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=232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dfaaeab478c84d907092b60a6945cccb5fbb7e3b192820a61308aaf97b9caa7d1c19d28560ff52b946edfe2a0a666923ed28147ad56f12a12b84e12ecc31d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf87edd2e2334e4f389f8923930ce78d421ae35c13f4b7e5b9a756e454e499434d1938ae9f0ac3fdfd85624cc29bf009b2c77c4b2c2616e77598423a8dc5f8a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d336bbcfb9b6d57033d9de6d27766d8f2fdd86582d9c0fd47b90b6baa3dceaac082a295fd3dd7f196a4efeee2f241817892ca1a70d5ba368fd3b34dd312508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f0c371306d367fefd110c5da6616b31331b4d4f60eb96342e399b03861d3bc869a4e27426e463591b79be9ea5f0f371ca5d903f819d2aa5ab12a7acf29a7a0"} build_url:https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011479 build_url: 'https://queue.taskcluster.net/v1/task/dLDVm_EqRZa_BlWLe4eS3w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dfaaeab478c84d907092b60a6945cccb5fbb7e3b192820a61308aaf97b9caa7d1c19d28560ff52b946edfe2a0a666923ed28147ad56f12a12b84e12ecc31d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf87edd2e2334e4f389f8923930ce78d421ae35c13f4b7e5b9a756e454e499434d1938ae9f0ac3fdfd85624cc29bf009b2c77c4b2c2616e77598423a8dc5f8a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d336bbcfb9b6d57033d9de6d27766d8f2fdd86582d9c0fd47b90b6baa3dceaac082a295fd3dd7f196a4efeee2f241817892ca1a70d5ba368fd3b34dd312508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f0c371306d367fefd110c5da6616b31331b4d4f60eb96342e399b03861d3bc869a4e27426e463591b79be9ea5f0f371ca5d903f819d2aa5ab12a7acf29a7a0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 05:57:10.826343) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:57:10.826653) ========= 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=232498196343f89f466a4a9a000001c8-1486474505.40251-1200311793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 05:57:10.908585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 05:57:10.908896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 05:57:10.909211) ========= ========= Total master_lag: 0.15 =========