builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1486433544.94 results: success (0) revision: 4f8b2d44eaa0c67bc7e7f5bac4e41e9a4b2e27c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:24.942833) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:24.943262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:24.943564) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:24.960179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:24.960552) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 18:12:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-02-06 18:12:25 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.068134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.068541) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019291 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.121415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.124857) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f8b2d44eaa0c67bc7e7f5bac4e41e9a4b2e27c7 --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 4f8b2d44eaa0c67bc7e7f5bac4e41e9a4b2e27c7 --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=a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 18:12:25,353 truncating revision to first 12 chars 2017-02-06 18:12:25,353 Setting DEBUG logging. 2017-02-06 18:12:25,353 attempt 1/10 2017-02-06 18:12:25,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f8b2d44eaa0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 18:12:25,849 unpacking tar archive at: mozilla-central-4f8b2d44eaa0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.928829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.929237) ========= script_repo_revision: 4f8b2d44eaa0c67bc7e7f5bac4e41e9a4b2e27c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.929638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.929902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 18:12:25.940639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-02-06 18:12:25.941024) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:12:26 INFO - MultiFileLogger online at 20170206 18:12:26 in /builds/slave/test 18:12:26 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 18:12:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:12:26 INFO - {'append_to_log': False, 18:12:26 INFO - 'base_work_dir': '/builds/slave/test', 18:12:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:12:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:12:26 INFO - 'branch': 'Firefox-Non-PGO', 18:12:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:12:26 INFO - 'config_files': ('talos/linux_config.py',), 18:12:26 INFO - 'default_actions': ('clobber', 18:12:26 INFO - 'read-buildbot-config', 18:12:26 INFO - 'download-and-extract', 18:12:26 INFO - 'populate-webroot', 18:12:26 INFO - 'create-virtualenv', 18:12:26 INFO - 'install', 18:12:26 INFO - 'run-tests'), 18:12:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:12:26 INFO - 'download_minidump_stackwalk': True, 18:12:26 INFO - 'download_symbols': 'ondemand', 18:12:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:12:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:12:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:12:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:12:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:12:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:12:26 INFO - 'installer_path': 'installer.exe', 18:12:26 INFO - 'log_level': 'info', 18:12:26 INFO - 'log_name': 'talos', 18:12:26 INFO - 'log_to_console': True, 18:12:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:12:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:12:26 INFO - 'opt_config_files': (), 18:12:26 INFO - 'pip_index': False, 18:12:26 INFO - 'sps_profile': False, 18:12:26 INFO - 'sps_profile_interval': 0, 18:12:26 INFO - 'suite': 'dromaeojs-e10s', 18:12:26 INFO - 'system_bits': '32', 18:12:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:12:26 INFO - 'title': 'talos-linux64-ix-062', 18:12:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:12:26 INFO - 'use_talos_json': True, 18:12:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:12:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:12:26 INFO - 'work_dir': 'build'} 18:12:26 INFO - [mozharness: 2017-02-07 02:12:26.263608Z] Running clobber step. 18:12:26 INFO - Running pre-action listener: _resource_record_pre_action 18:12:26 INFO - Running main action method: clobber 18:12:26 INFO - rmtree: /builds/slave/test/build 18:12:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:12:26 INFO - Running post-action listener: _resource_record_post_action 18:12:26 INFO - [mozharness: 2017-02-07 02:12:26.734758Z] Finished clobber step (success) 18:12:26 INFO - [mozharness: 2017-02-07 02:12:26.734859Z] Running read-buildbot-config step. 18:12:26 INFO - Running pre-action listener: _resource_record_pre_action 18:12:26 INFO - Running main action method: read_buildbot_config 18:12:26 INFO - Using buildbot properties: 18:12:26 INFO - { 18:12:26 INFO - "project": "", 18:12:26 INFO - "product": "firefox", 18:12:26 INFO - "who": "kwierso@gmail.com", 18:12:26 INFO - "installer_path": "public/build/target.tar.bz2", 18:12:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:12:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:12:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:12:26 INFO - "stage_platform": "linux64", 18:12:26 INFO - "basedir": "/builds/slave/test", 18:12:26 INFO - "buildnumber": 685, 18:12:26 INFO - "platform": "ubuntu64_hw", 18:12:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:12:26 INFO - "slavebuilddir": "test", 18:12:26 INFO - "taskId": "BsyueI5fTJqYXHYwDNgoXQ", 18:12:26 INFO - "branch": "mozilla-central", 18:12:26 INFO - "script_repo_revision": "production", 18:12:26 INFO - "revision": "4f8b2d44eaa0c67bc7e7f5bac4e41e9a4b2e27c7", 18:12:26 INFO - "slavename": "talos-linux64-ix-062", 18:12:26 INFO - "repo_path": "mozilla-central" 18:12:26 INFO - } 18:12:26 INFO - Finding installer, test and symbols from parent task. 18:12:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BsyueI5fTJqYXHYwDNgoXQ'}, attempt #1 18:12:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BsyueI5fTJqYXHYwDNgoXQ'}, attempt #1 18:12:27 INFO - Task dependencies: dU13_w-NTQGojHqBqkwY4A 18:12:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A'}, attempt #1 18:12:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2 18:12:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/test_packages.json 18:12:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.crashreporter-symbols.zip 18:12:28 INFO - Running post-action listener: _resource_record_post_action 18:12:28 INFO - [mozharness: 2017-02-07 02:12:28.270562Z] Finished read-buildbot-config step (success) 18:12:28 INFO - [mozharness: 2017-02-07 02:12:28.270780Z] Running download-and-extract step. 18:12:28 INFO - Running pre-action listener: _resource_record_pre_action 18:12:28 INFO - Running main action method: download_and_extract 18:12:28 INFO - mkdir: /builds/slave/test/build/tests 18:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:28 INFO - trying https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.test_packages.json 18:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:12:28 INFO - Downloaded 896 bytes. 18:12:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:12:28 INFO - Using the following test package requirements: 18:12:28 INFO - {u'common': [u'target.common.tests.zip'], 18:12:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:12:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:12:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:12:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:12:28 INFO - u'mozbase': [u'target.common.tests.zip'], 18:12:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:12:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:12:28 INFO - u'web-platform': [u'target.common.tests.zip', 18:12:28 INFO - u'target.web-platform.tests.zip'], 18:12:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:12:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:12:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.common.tests.zip 18:12:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:12:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.common.tests.zip into memory 18:12:29 INFO - Expected file size: 39903135 18:12:29 INFO - Obtained file size: 39903135 18:12:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:12:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.common.tests.zip 18:12:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:12:34 INFO - Fetch https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.common.tests.zip into memory 18:12:35 INFO - Expected file size: 39903135 18:12:35 INFO - Obtained file size: 39903135 18:12:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.talos.tests.zip 18:12:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:12:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.talos.tests.zip into memory 18:12:40 INFO - Expected file size: 14403454 18:12:40 INFO - Obtained file size: 14403454 18:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:40 INFO - trying https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2 18:12:40 INFO - Downloading https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:12:41 INFO - Downloaded 56321493 bytes. 18:12:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2 18:12:41 INFO - mkdir: /builds/slave/test/properties 18:12:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:12:41 INFO - Writing to file /builds/slave/test/properties/build_url 18:12:41 INFO - Contents: 18:12:41 INFO - build_url:https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2 18:12:41 INFO - Running post-action listener: _resource_record_post_action 18:12:41 INFO - Running post-action listener: set_extra_try_arguments 18:12:41 INFO - [mozharness: 2017-02-07 02:12:41.917968Z] Finished download-and-extract step (success) 18:12:41 INFO - [mozharness: 2017-02-07 02:12:41.918065Z] Running populate-webroot step. 18:12:41 INFO - Running pre-action listener: _resource_record_pre_action 18:12:41 INFO - Running main action method: populate_webroot 18:12:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:12:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:12:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:12:41 INFO - '--tppagecycles', 18:12:41 INFO - '7'], 18:12:41 INFO - 'tests': ['tsvgm']}}, 18:12:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:12:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:12:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:12:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:12:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:12:41 INFO - 'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:12:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:12:41 INFO - 'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['damp', 'tps']}, 18:12:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:12:41 INFO - 'tests': ['damp', 'tps']}, 18:12:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['dromaeo_dom']}, 18:12:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:12:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['basic_compositor_video']}, 18:12:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:12:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['a11yr', 18:12:41 INFO - 'ts_paint', 18:12:41 INFO - 'tpaint', 18:12:41 INFO - 'sessionrestore', 18:12:41 INFO - 'sessionrestore_no_auto_restore', 18:12:41 INFO - 'tabpaint']}, 18:12:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:12:41 INFO - 'ts_paint', 18:12:41 INFO - 'tpaint', 18:12:41 INFO - 'sessionrestore', 18:12:41 INFO - 'sessionrestore_no_auto_restore', 18:12:41 INFO - 'tabpaint']}, 18:12:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:12:41 INFO - 'ts_paint', 18:12:41 INFO - 'tpaint', 18:12:41 INFO - 'sessionrestore', 18:12:41 INFO - 'sessionrestore_no_auto_restore', 18:12:41 INFO - 'tabpaint']}, 18:12:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:12:41 INFO - 'ts_paint', 18:12:41 INFO - 'tpaint', 18:12:41 INFO - 'sessionrestore', 18:12:41 INFO - 'sessionrestore_no_auto_restore', 18:12:41 INFO - 'tabpaint']}, 18:12:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['a11yr', 18:12:41 INFO - 'ts_paint', 18:12:41 INFO - 'tpaint', 18:12:41 INFO - 'sessionrestore', 18:12:41 INFO - 'sessionrestore_no_auto_restore', 18:12:41 INFO - 'tabpaint']}, 18:12:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['a11yr', 18:12:41 INFO - 'ts_paint', 18:12:41 INFO - 'tpaint', 18:12:41 INFO - 'sessionrestore', 18:12:41 INFO - 'sessionrestore_no_auto_restore', 18:12:41 INFO - 'tabpaint']}, 18:12:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['tsvgx', 18:12:41 INFO - 'tsvgr_opacity', 18:12:41 INFO - 'tart', 18:12:41 INFO - 'tscrollx', 18:12:41 INFO - 'cart', 18:12:41 INFO - 'tsvg_static']}, 18:12:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:12:41 INFO - 'tsvgr_opacity', 18:12:41 INFO - 'tart', 18:12:41 INFO - 'tscrollx', 18:12:41 INFO - 'cart', 18:12:41 INFO - 'tsvg_static']}, 18:12:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:12:41 INFO - 'talos_options': ['--disable-e10s'], 18:12:41 INFO - 'tests': ['tp5o']}, 18:12:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:12:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:12:41 INFO - 'talos_options': ['--disable-e10s', 18:12:41 INFO - '--xperf_path', 18:12:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:41 INFO - 'tests': ['tp5n']}, 18:12:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:12:41 INFO - 'talos_options': ['--xperf_path', 18:12:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:41 INFO - 'tests': ['tp5n']}}, 18:12:41 INFO - 'talos.zip': {'path': '', 18:12:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:12:41 INFO - Running post-action listener: _resource_record_post_action 18:12:41 INFO - [mozharness: 2017-02-07 02:12:41.931284Z] Finished populate-webroot step (success) 18:12:41 INFO - [mozharness: 2017-02-07 02:12:41.931374Z] Running create-virtualenv step. 18:12:41 INFO - Running pre-action listener: _resource_record_pre_action 18:12:41 INFO - Running main action method: create_virtualenv 18:12:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:12:41 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 18:12:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:12:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:12:42 INFO - Using real prefix '/usr' 18:12:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:12:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:12:44 INFO - Installing pip.................done. 18:12:44 INFO - Return code: 0 18:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:12:44 INFO - Reading from file tmpfile_stdout 18:12:44 INFO - Output received: 18:12:44 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) 18:12:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:12: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', 'pip>=1.5'] in /builds/slave/test/build 18:12: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 pip>=1.5 18:12:44 INFO - Using env: {'DISPLAY': ':0', 18:12:44 INFO - 'HOME': '/home/cltbld', 18:12:44 INFO - 'LANG': 'en_US.UTF-8', 18:12:44 INFO - 'LANGUAGE': 'en_US:en', 18:12:44 INFO - 'LOGNAME': 'cltbld', 18:12:44 INFO - 'MAIL': '/var/mail/cltbld', 18:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:44 INFO - 'MOZ_NO_REMOTE': '1', 18:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:44 INFO - 'NO_EM_RESTART': '1', 18:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:44 INFO - 'PWD': '/builds/slave/test', 18:12:44 INFO - 'SHELL': '/bin/bash', 18:12:44 INFO - 'SHLVL': '1', 18:12:44 INFO - 'TERM': 'linux', 18:12:44 INFO - 'TMOUT': '86400', 18:12:44 INFO - 'USER': 'cltbld', 18:12:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:44 INFO - '_': '/tools/buildbot/bin/python'} 18:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:44 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 18:12:44 INFO - Cleaning up... 18:12:44 INFO - Return code: 0 18:12:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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', '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 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:12: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 psutil>=3.1.1 18:12:44 INFO - Using env: {'DISPLAY': ':0', 18:12:44 INFO - 'HOME': '/home/cltbld', 18:12:44 INFO - 'LANG': 'en_US.UTF-8', 18:12:44 INFO - 'LANGUAGE': 'en_US:en', 18:12:44 INFO - 'LOGNAME': 'cltbld', 18:12:44 INFO - 'MAIL': '/var/mail/cltbld', 18:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:44 INFO - 'MOZ_NO_REMOTE': '1', 18:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:44 INFO - 'NO_EM_RESTART': '1', 18:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:44 INFO - 'PWD': '/builds/slave/test', 18:12:44 INFO - 'SHELL': '/bin/bash', 18:12:44 INFO - 'SHLVL': '1', 18:12:44 INFO - 'TERM': 'linux', 18:12:44 INFO - 'TMOUT': '86400', 18:12:44 INFO - 'USER': 'cltbld', 18:12:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:44 INFO - '_': '/tools/buildbot/bin/python'} 18:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:45 INFO - Downloading/unpacking psutil>=3.1.1 18:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:47 INFO - Installing collected packages: psutil 18:12:47 INFO - Running setup.py install for psutil 18:12:47 INFO - building 'psutil._psutil_linux' extension 18:12:47 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 18:12:47 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 18:12:47 INFO - building 'psutil._psutil_posix' extension 18:12:47 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 18:12:47 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 18:12:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:47 INFO - Successfully installed psutil 18:12:47 INFO - Cleaning up... 18:12:47 INFO - Return code: 0 18:12:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:12: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 mozsystemmonitor==0.3 18:12:47 INFO - Using env: {'DISPLAY': ':0', 18:12:47 INFO - 'HOME': '/home/cltbld', 18:12:47 INFO - 'LANG': 'en_US.UTF-8', 18:12:47 INFO - 'LANGUAGE': 'en_US:en', 18:12:47 INFO - 'LOGNAME': 'cltbld', 18:12:47 INFO - 'MAIL': '/var/mail/cltbld', 18:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:47 INFO - 'MOZ_NO_REMOTE': '1', 18:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:47 INFO - 'NO_EM_RESTART': '1', 18:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:47 INFO - 'PWD': '/builds/slave/test', 18:12:47 INFO - 'SHELL': '/bin/bash', 18:12:47 INFO - 'SHLVL': '1', 18:12:47 INFO - 'TERM': 'linux', 18:12:47 INFO - 'TMOUT': '86400', 18:12:47 INFO - 'USER': 'cltbld', 18:12:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:47 INFO - '_': '/tools/buildbot/bin/python'} 18:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:12:50 INFO - Installing collected packages: mozsystemmonitor 18:12:50 INFO - Running setup.py install for mozsystemmonitor 18:12:50 INFO - Successfully installed mozsystemmonitor 18:12:50 INFO - Cleaning up... 18:12:50 INFO - Return code: 0 18:12:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:50 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 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:12:50 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 18:12:50 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 18:12:50 INFO - Using env: {'DISPLAY': ':0', 18:12:50 INFO - 'HOME': '/home/cltbld', 18:12:50 INFO - 'LANG': 'en_US.UTF-8', 18:12:50 INFO - 'LANGUAGE': 'en_US:en', 18:12:50 INFO - 'LOGNAME': 'cltbld', 18:12:50 INFO - 'MAIL': '/var/mail/cltbld', 18:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:50 INFO - 'MOZ_NO_REMOTE': '1', 18:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:50 INFO - 'NO_EM_RESTART': '1', 18:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:50 INFO - 'PWD': '/builds/slave/test', 18:12:50 INFO - 'SHELL': '/bin/bash', 18:12:50 INFO - 'SHLVL': '1', 18:12:50 INFO - 'TERM': 'linux', 18:12:50 INFO - 'TMOUT': '86400', 18:12:50 INFO - 'USER': 'cltbld', 18:12:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:50 INFO - '_': '/tools/buildbot/bin/python'} 18:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:50 INFO - Downloading/unpacking jsonschema==2.5.1 18:12:50 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 18:12:50 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 18:12:50 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 18:12:50 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 18:12:50 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 18:12:50 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 18:12:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12:52 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 18:12:52 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 18:12:52 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 18:12:52 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 18:12:52 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 18:12:52 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 18:12:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:52 INFO - warning: no files found matching '*.txt' 18:12:52 INFO - no previously-included directories found matching 'build' 18:12:52 INFO - no previously-included directories found matching 'dist' 18:12:52 INFO - no previously-included directories found matching '.git*' 18:12:52 INFO - Installing collected packages: jsonschema, functools32 18:12:53 INFO - Running setup.py install for functools32 18:12:53 INFO - warning: no files found matching '*.txt' 18:12:53 INFO - no previously-included directories found matching 'build' 18:12:53 INFO - no previously-included directories found matching 'dist' 18:12:53 INFO - no previously-included directories found matching '.git*' 18:12:53 INFO - Successfully installed jsonschema functools32 18:12:53 INFO - Cleaning up... 18:12:53 INFO - Return code: 0 18:12:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:12:53 INFO - Using env: {'DISPLAY': ':0', 18:12:53 INFO - 'HOME': '/home/cltbld', 18:12:53 INFO - 'LANG': 'en_US.UTF-8', 18:12:53 INFO - 'LANGUAGE': 'en_US:en', 18:12:53 INFO - 'LOGNAME': 'cltbld', 18:12:53 INFO - 'MAIL': '/var/mail/cltbld', 18:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:53 INFO - 'MOZ_NO_REMOTE': '1', 18:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:53 INFO - 'NO_EM_RESTART': '1', 18:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:53 INFO - 'PWD': '/builds/slave/test', 18:12:53 INFO - 'SHELL': '/bin/bash', 18:12:53 INFO - 'SHLVL': '1', 18:12:53 INFO - 'TERM': 'linux', 18:12:53 INFO - 'TMOUT': '86400', 18:12:53 INFO - 'USER': 'cltbld', 18:12:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:53 INFO - '_': '/tools/buildbot/bin/python'} 18:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:12:53 INFO - Cleaning up... 18:12:53 INFO - Return code: 0 18:12:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:12:53 INFO - Using env: {'DISPLAY': ':0', 18:12:53 INFO - 'HOME': '/home/cltbld', 18:12:53 INFO - 'LANG': 'en_US.UTF-8', 18:12:53 INFO - 'LANGUAGE': 'en_US:en', 18:12:53 INFO - 'LOGNAME': 'cltbld', 18:12:53 INFO - 'MAIL': '/var/mail/cltbld', 18:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:53 INFO - 'MOZ_NO_REMOTE': '1', 18:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:53 INFO - 'NO_EM_RESTART': '1', 18:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:53 INFO - 'PWD': '/builds/slave/test', 18:12:53 INFO - 'SHELL': '/bin/bash', 18:12:53 INFO - 'SHLVL': '1', 18:12:53 INFO - 'TERM': 'linux', 18:12:53 INFO - 'TMOUT': '86400', 18:12:53 INFO - 'USER': 'cltbld', 18:12:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:53 INFO - '_': '/tools/buildbot/bin/python'} 18:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:53 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:56 INFO - Downloading docopt-0.6.1.tar.gz 18:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:56 INFO - Running setup.py install for blobuploader 18:12:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:56 INFO - Running setup.py install for requests 18:12:56 INFO - Running setup.py install for docopt 18:12:57 INFO - Successfully installed blobuploader requests docopt 18:12:57 INFO - Cleaning up... 18:12:57 INFO - Return code: 0 18:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:57 INFO - Using env: {'DISPLAY': ':0', 18:12:57 INFO - 'HOME': '/home/cltbld', 18:12:57 INFO - 'LANG': 'en_US.UTF-8', 18:12:57 INFO - 'LANGUAGE': 'en_US:en', 18:12:57 INFO - 'LOGNAME': 'cltbld', 18:12:57 INFO - 'MAIL': '/var/mail/cltbld', 18:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:57 INFO - 'MOZ_NO_REMOTE': '1', 18:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:57 INFO - 'NO_EM_RESTART': '1', 18:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:57 INFO - 'PWD': '/builds/slave/test', 18:12:57 INFO - 'SHELL': '/bin/bash', 18:12:57 INFO - 'SHLVL': '1', 18:12:57 INFO - 'TERM': 'linux', 18:12:57 INFO - 'TMOUT': '86400', 18:12:57 INFO - 'USER': 'cltbld', 18:12:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:57 INFO - '_': '/tools/buildbot/bin/python'} 18:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:57 INFO - Running setup.py (path:/tmp/pip-iDQbtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:57 INFO - Running setup.py (path:/tmp/pip-7rsvtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:57 INFO - Running setup.py (path:/tmp/pip-gmN_wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:57 INFO - Running setup.py (path:/tmp/pip-Ccz6gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:57 INFO - Running setup.py (path:/tmp/pip-nNa9r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:57 INFO - Running setup.py (path:/tmp/pip-FSCEUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:57 INFO - Running setup.py (path:/tmp/pip-i7UUAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:57 INFO - Running setup.py (path:/tmp/pip-HkkZ5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:57 INFO - Running setup.py (path:/tmp/pip-E6HMfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:58 INFO - Running setup.py (path:/tmp/pip-MdPayY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:58 INFO - Running setup.py (path:/tmp/pip-AvOnZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:58 INFO - Running setup.py (path:/tmp/pip-X40hNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:58 INFO - Running setup.py (path:/tmp/pip-IRMaaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:58 INFO - Running setup.py (path:/tmp/pip-8dZhps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:58 INFO - Running setup.py (path:/tmp/pip-ftJJaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:58 INFO - Running setup.py (path:/tmp/pip-y6sW9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:58 INFO - Running setup.py (path:/tmp/pip-BGOCCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:58 INFO - Running setup.py install for manifestparser 18:12:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:58 INFO - Running setup.py install for mozcrash 18:12:58 INFO - Running setup.py install for mozdebug 18:12:58 INFO - Running setup.py install for mozdevice 18:12:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Running setup.py install for mozfile 18:12:59 INFO - Running setup.py install for mozhttpd 18:12:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Running setup.py install for mozinfo 18:12:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Running setup.py install for mozInstall 18:12:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Running setup.py install for mozleak 18:12:59 INFO - Running setup.py install for mozlog 18:12:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Running setup.py install for moznetwork 18:12:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Running setup.py install for mozprocess 18:12:59 INFO - Running setup.py install for mozprofile 18:12:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:59 INFO - Running setup.py install for mozrunner 18:13:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:13:00 INFO - Running setup.py install for mozscreenshot 18:13:00 INFO - Running setup.py install for moztest 18:13:00 INFO - Running setup.py install for mozversion 18:13:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:13:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:13:00 INFO - Cleaning up... 18:13:00 INFO - Return code: 0 18:13:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:13:00 INFO - Using env: {'DISPLAY': ':0', 18:13:00 INFO - 'HOME': '/home/cltbld', 18:13:00 INFO - 'LANG': 'en_US.UTF-8', 18:13:00 INFO - 'LANGUAGE': 'en_US:en', 18:13:00 INFO - 'LOGNAME': 'cltbld', 18:13:00 INFO - 'MAIL': '/var/mail/cltbld', 18:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:00 INFO - 'MOZ_NO_REMOTE': '1', 18:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:00 INFO - 'NO_EM_RESTART': '1', 18:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:00 INFO - 'PWD': '/builds/slave/test', 18:13:00 INFO - 'SHELL': '/bin/bash', 18:13:00 INFO - 'SHLVL': '1', 18:13:00 INFO - 'TERM': 'linux', 18:13:00 INFO - 'TMOUT': '86400', 18:13:00 INFO - 'USER': 'cltbld', 18:13:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:00 INFO - '_': '/tools/buildbot/bin/python'} 18:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:13:00 INFO - Running setup.py (path:/tmp/pip-Ppir8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:13:00 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)) 18:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:13:00 INFO - Running setup.py (path:/tmp/pip-Roz0av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:13:00 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)) 18:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:13:00 INFO - Running setup.py (path:/tmp/pip-8IGelV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:13:00 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)) 18:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:13:00 INFO - Running setup.py (path:/tmp/pip-D0FOxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:13:00 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)) 18:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:13:00 INFO - Running setup.py (path:/tmp/pip-0smnUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:13:01 INFO - Running setup.py (path:/tmp/pip-V5gIsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:13:01 INFO - Running setup.py (path:/tmp/pip-LOwmlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:13:01 INFO - Running setup.py (path:/tmp/pip-MCSFZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:13:01 INFO - Running setup.py (path:/tmp/pip-LJo3Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:13:01 INFO - Running setup.py (path:/tmp/pip-vgoX6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:13:01 INFO - Running setup.py (path:/tmp/pip-k7pIGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:13:01 INFO - Running setup.py (path:/tmp/pip-s8Kqcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:13:01 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)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:13:01 INFO - Running setup.py (path:/tmp/pip-bZerNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:13:01 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)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:13:01 INFO - Running setup.py (path:/tmp/pip-el7niK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:13:01 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)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:01 INFO - Running setup.py (path:/tmp/pip-gTKlaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:01 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)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:13:01 INFO - Running setup.py (path:/tmp/pip-TL9kxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:13:01 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)) 18:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:13:01 INFO - Running setup.py (path:/tmp/pip-L10Wsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:13:01 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)) 18:13:01 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)) 18:13:01 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)) 18:13:01 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)) 18:13:01 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)) 18:13:01 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)) 18:13:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:13:01 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 18:13:01 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 18:13:01 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 18:13:01 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 18:13:01 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 18:13:01 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 18:13:03 INFO - Downloading blessings-1.6.tar.gz 18:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:13:04 INFO - Installing collected packages: blessings 18:13:04 INFO - Running setup.py install for blessings 18:13:04 INFO - Successfully installed blessings 18:13:04 INFO - Cleaning up... 18:13:04 INFO - Return code: 0 18:13:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:04 INFO - Reading from file tmpfile_stdout 18:13:04 INFO - Current package versions: 18:13:04 INFO - argparse == 1.2.1 18:13:04 INFO - blessings == 1.6 18:13:04 INFO - blobuploader == 1.2.4 18:13:04 INFO - docopt == 0.6.1 18:13:04 INFO - functools32 == 3.2.3-2 18:13:04 INFO - jsonschema == 2.5.1 18:13:04 INFO - manifestparser == 1.1 18:13:04 INFO - mozInstall == 1.12 18:13:04 INFO - mozcrash == 1.0 18:13:04 INFO - mozdebug == 0.1 18:13:04 INFO - mozdevice == 0.49 18:13:04 INFO - mozfile == 1.2 18:13:04 INFO - mozhttpd == 0.7 18:13:04 INFO - mozinfo == 0.9 18:13:04 INFO - mozleak == 0.1 18:13:04 INFO - mozlog == 3.4 18:13:04 INFO - moznetwork == 0.27 18:13:04 INFO - mozprocess == 0.24 18:13:04 INFO - mozprofile == 0.28 18:13:04 INFO - mozrunner == 6.13 18:13:04 INFO - mozscreenshot == 0.1 18:13:04 INFO - mozsystemmonitor == 0.3 18:13:04 INFO - moztest == 0.8 18:13:04 INFO - mozversion == 1.4 18:13:04 INFO - psutil == 3.1.1 18:13:04 INFO - requests == 1.2.3 18:13:04 INFO - wsgiref == 0.1.2 18:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:13:04 INFO - Using env: {'DISPLAY': ':0', 18:13:04 INFO - 'HOME': '/home/cltbld', 18:13:04 INFO - 'LANG': 'en_US.UTF-8', 18:13:04 INFO - 'LANGUAGE': 'en_US:en', 18:13:04 INFO - 'LOGNAME': 'cltbld', 18:13:04 INFO - 'MAIL': '/var/mail/cltbld', 18:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:04 INFO - 'MOZ_NO_REMOTE': '1', 18:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:04 INFO - 'NO_EM_RESTART': '1', 18:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:04 INFO - 'PWD': '/builds/slave/test', 18:13:04 INFO - 'SHELL': '/bin/bash', 18:13:04 INFO - 'SHLVL': '1', 18:13:04 INFO - 'TERM': 'linux', 18:13:04 INFO - 'TMOUT': '86400', 18:13:04 INFO - 'USER': 'cltbld', 18:13:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:04 INFO - '_': '/tools/buildbot/bin/python'} 18:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 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)) 18:13:04 INFO - Cleaning up... 18:13:04 INFO - Return code: 0 18:13:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b22480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', '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 18:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:13:04 INFO - Using env: {'DISPLAY': ':0', 18:13:04 INFO - 'HOME': '/home/cltbld', 18:13:04 INFO - 'LANG': 'en_US.UTF-8', 18:13:04 INFO - 'LANGUAGE': 'en_US:en', 18:13:04 INFO - 'LOGNAME': 'cltbld', 18:13:04 INFO - 'MAIL': '/var/mail/cltbld', 18:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:04 INFO - 'MOZ_NO_REMOTE': '1', 18:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:04 INFO - 'NO_EM_RESTART': '1', 18:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:04 INFO - 'PWD': '/builds/slave/test', 18:13:04 INFO - 'SHELL': '/bin/bash', 18:13:04 INFO - 'SHLVL': '1', 18:13:04 INFO - 'TERM': 'linux', 18:13:04 INFO - 'TMOUT': '86400', 18:13:04 INFO - 'USER': 'cltbld', 18:13:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:04 INFO - '_': '/tools/buildbot/bin/python'} 18:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:13:04 INFO - Cleaning up... 18:13:04 INFO - Return code: 0 18:13:04 INFO - Running post-action listener: _resource_record_post_action 18:13:04 INFO - Running post-action listener: _start_resource_monitoring 18:13:04 INFO - Starting resource monitoring. 18:13:04 INFO - [mozharness: 2017-02-07 02:13:04.896602Z] Finished create-virtualenv step (success) 18:13:04 INFO - [mozharness: 2017-02-07 02:13:04.897052Z] Running install step. 18:13:04 INFO - Running pre-action listener: _resource_record_pre_action 18:13:04 INFO - Running main action method: install 18:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:05 INFO - Reading from file tmpfile_stdout 18:13:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:13:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:13:05 INFO - Reading from file tmpfile_stdout 18:13:05 INFO - Output received: 18:13:05 INFO - Usage: mozinstall [options] installer 18:13:05 INFO - Options: 18:13:05 INFO - -h, --help show this help message and exit 18:13:05 INFO - -d DEST, --destination=DEST 18:13:05 INFO - Directory to install application into. [default: 18:13:05 INFO - "/builds/slave/test"] 18:13:05 INFO - --app=APP Application being installed. [default: firefox] 18:13:05 INFO - mkdir: /builds/slave/test/build/application 18:13:05 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'] 18:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:13:21 INFO - Reading from file tmpfile_stdout 18:13:21 INFO - Output received: 18:13:21 INFO - /builds/slave/test/build/application/firefox/firefox 18:13:21 INFO - Running post-action listener: _resource_record_post_action 18:13:21 INFO - [mozharness: 2017-02-07 02:13:21.426012Z] Finished install step (success) 18:13:21 INFO - [mozharness: 2017-02-07 02:13:21.426176Z] Running run-tests step. 18:13:21 INFO - Running pre-action listener: _resource_record_pre_action 18:13:21 INFO - Running main action method: run_tests 18:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:13:21 INFO - Python 2.7.3 18:13:21 INFO - Return code: 0 18:13:21 INFO - grabbing minidump binary from tooltool 18:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:21 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 0x1b1f820>, '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 0x1b20520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b209b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:13:21 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 18:13:21 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 18:13:21 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 18:13:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:13:21 INFO - Return code: 0 18:13:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:13:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:13:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:13:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:13:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:13:21 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/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 18:13:21 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/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 18:13:21 INFO - Using env: {'DISPLAY': ':0', 18:13:21 INFO - 'HOME': '/home/cltbld', 18:13:21 INFO - 'LANG': 'en_US.UTF-8', 18:13:21 INFO - 'LANGUAGE': 'en_US:en', 18:13:21 INFO - 'LOGNAME': 'cltbld', 18:13:21 INFO - 'MAIL': '/var/mail/cltbld', 18:13:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:13:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:21 INFO - 'MOZ_NO_REMOTE': '1', 18:13:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:21 INFO - 'NO_EM_RESTART': '1', 18:13:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:21 INFO - 'PWD': '/builds/slave/test', 18:13:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:13:21 INFO - 'SHELL': '/bin/bash', 18:13:21 INFO - 'SHLVL': '1', 18:13:21 INFO - 'TERM': 'linux', 18:13:21 INFO - 'TMOUT': '86400', 18:13:21 INFO - 'USER': 'cltbld', 18:13:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434', 18:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:21 INFO - '_': '/tools/buildbot/bin/python'} 18:13:21 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/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 18:13:21 INFO - mozversion application_buildid: 20170207013759 18:13:21 INFO - mozversion application_changeset: 4f8b2d44eaa0c67bc7e7f5bac4e41e9a4b2e27c7 18:13:21 INFO - mozversion application_display_name: Nightly 18:13:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:13:21 INFO - mozversion application_name: Firefox 18:13:21 INFO - mozversion application_remotingname: firefox 18:13:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:13:21 INFO - mozversion application_vendor: Mozilla 18:13:21 INFO - mozversion application_version: 54.0a1 18:13:21 INFO - mozversion platform_buildid: 20170207013759 18:13:21 INFO - mozversion platform_changeset: 4f8b2d44eaa0c67bc7e7f5bac4e41e9a4b2e27c7 18:13:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:13:21 INFO - mozversion platform_version: 54.0a1 18:13:21 INFO - using testdate: 1486433601 18:13:21 INFO - actual date: 1486433601 18:13:21 INFO - starting webserver on 'localhost:52676' 18:13:21 INFO - SUITE-START | Running 2 tests 18:13:21 INFO - TEST-START | dromaeo_css 18:13:21 INFO - operating with platform_type : linux_ 18:13:21 INFO - Initialising browser for dromaeo_css test... 18:13:21 INFO - TEST-INFO | started process 12862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGn_dh2/profile http://localhost:52676/getInfo.html) 18:13:25 INFO - PROCESS | 12862 | 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] 18:13:25 INFO - PROCESS | 12862 | __metrics Screen width/height:1600/1200 18:13:25 INFO - PROCESS | 12862 | colorDepth:24 18:13:25 INFO - PROCESS | 12862 | Browser inner width/height: 1024/697 18:13:25 INFO - PROCESS | 12862 | __metrics 18:13:26 INFO - PROCESS | 12862 | 1486433606405 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:6303:36 < canClose@browser.js:5169:12 < forceQuit@jar:file:///tmp/tmpGn_dh2/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpGn_dh2/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpGn_dh2/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpGn_dh2/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:13:26 ERROR - PROCESS | 12862 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 18:13:27 INFO - TEST-INFO | 12862: exit 0 18:13:27 INFO - Browser initialized. 18:13:27 INFO - Running cycle 1/1 for dromaeo_css test... 18:13:27 INFO - TEST-INFO | started process 12981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGn_dh2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:39 INFO - PROCESS | 12981 | RSS: Main: 162549760 18:13:39 INFO - PROCESS | 12981 | 18:16:43 INFO - PROCESS | 12981 | Cycle 1(1): loaded http://localhost:52676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52676/tests/dromaeo/cssquery-ext.html) 18:16:45 INFO - PROCESS | 12981 | RSS: Main: 169287680 18:16:45 INFO - PROCESS | 12981 | 18:18:27 INFO - PROCESS | 12981 | ************************* 18:18:27 INFO - PROCESS | 12981 | A coding exception was thrown and uncaught in a Task. 18:18:27 INFO - PROCESS | 12981 | 18:18:27 ERROR - PROCESS | 12981 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:18:27 INFO - PROCESS | 12981 | Full stack: 18:18:27 INFO - PROCESS | 12981 | ************************* 18:19:48 INFO - PROCESS | 12981 | Cycle 1(1): loaded http://localhost:52676/tests/dromaeo/cssquery-ext.html (next: http://localhost:52676/tests/dromaeo/cssquery-jquery.html) 18:19:48 INFO - PROCESS | 12981 | RSS: Main: 163913728 18:19:48 INFO - PROCESS | 12981 | 18:22:51 INFO - PROCESS | 12981 | Cycle 1(1): loaded http://localhost:52676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52676/tests/dromaeo/cssquery-mootools.html) 18:22:51 INFO - PROCESS | 12981 | RSS: Main: 170766336 18:22:51 INFO - PROCESS | 12981 | 18:25:53 INFO - PROCESS | 12981 | Cycle 1(1): loaded http://localhost:52676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52676/tests/dromaeo/cssquery-prototype.html) 18:25:54 INFO - PROCESS | 12981 | RSS: Main: 164179968 18:25:54 INFO - PROCESS | 12981 | 18:28:57 INFO - PROCESS | 12981 | Cycle 1(1): loaded http://localhost:52676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52676/tests/dromaeo/cssquery-yui.html) 18:28:58 INFO - PROCESS | 12981 | RSS: Main: 168030208 18:28:58 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | Cycle 1(1): loaded http://localhost:52676/tests/dromaeo/cssquery-yui.html (next: http://localhost:52676/tests/dromaeo/cssquery-dojo.html) 18:32:01 INFO - PROCESS | 12981 | RSS: Main: 169005056 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | __start_tp_report 18:32:01 INFO - PROCESS | 12981 | _x_x_mozilla_page_load 18:32:01 INFO - PROCESS | 12981 | _x_x_mozilla_page_load_details 18:32:01 INFO - PROCESS | 12981 | |i|pagename|runs| 18:32:01 INFO - PROCESS | 12981 | |0;dojo.html;2542.110261408507;2556.578164602841;2575.7424257574244;2576.922692319231;2593.533164030475;4694.108119457301;4774.689645173065;4778.665493415462;4812.302216178652;4819.325294458778;4599;4668.136394766971;4716.952830471694;4829.058333624945;4879.09736698711;4143.3784932260105;4325.113351762889;4420.756858372788;4459.665525085616;4459.799309031101;4411.316245981862;4418.933715994247;4424.137293227822;4428.6014258716705;4462.3935383262;4276.5295817460055;4351.608355248011;4352.107817897323;4362.956370436286;4365.7817109144735;4315.43899293093;4339.60943515082;4354.7604881731495;4355.194289056535;4415.227335216357;4267.615914567704;4290.4636920384955;4357.564243575649;4364.912701745948;4394.714343567658;4578.839740609063;4623.653226008029;4651.790669419885;4743.264793956942;4751.3585665935;5092.770825312869;5108.693478391308;5145.897082058338;5177.818776342848;5189.532942035197;5147.279380886679;5159;5162;5174.301469301634;5211.687298762086;4593.701409408378;4808.495108013678;4819.662623616313;4820.035992801454;4843.636727245471;5052.747362631853;5102.285680004802;5116.948830511722;5136.1525348317855;5179.974100129475;4904.068227036852;4948.505149485023;4979.228219625964;4987.700737955734;4998.100341938413;5074.923876141861;5102.285680004802;5107.412647545506;5129.179331306973;5134;4914.213725803926;4961.70229786214;4989.525995030466;5007.298978143063;5036.219385995177;4937.481564435754;5082.542571168538;5126.564242039469;5129.333186685782;5182.714950677749;4416.3596278539435;4426.468823741107;4428.601425871622;4433.512313645497;4457.398251236106;3762.8682996095004;3813.1420430402936;3815.1797363566966;3817.4846395736777;3845.403962385835;4220.894477638022;4253.255680255943;4299.269124248885;4382.474103107584;4382.53983331752;5001.174806157016;5078.21287700407;5095.464976177522;5106.872328191825;5131.461196574381;4393.29707246839;4414.757188354672;4423;4437.134758722018;4438.533953934855;4418.756968366771;4537.8411755588395;4557.475890272594;4558.635309175258;4561.954380456219;4793.9280910787065;4832.323474713613;4836.12949669063;4859.1010663027455;4862.17343051675;5140.151874940593;5143.6399452037995;5145.125328694206;5152.76812543444;5172.612054095883;4665.720056796603;4706.176419126571;4724.244120940633;4748.667593268438;4822.156122678447;4960.553550180501;4973.303737476684;4990.076835785246;4992.2761199626575;5006.199008158677;5005.949940500694;5028.270900719302;5047.4700156484505;5053.823116190915;5129.948700512947;5021.799128034838;5028.396592408934;5029.9245511318095;5056.74716264178;5057.721825299644;5006.9735704181285;5015.949840501548;5020.021095886267;5024.648274620741;5048.268001139888;4758.405199350082;4851.369321988119;4908.993656300521;4916.532929371704;4976.452590215146;4981.327520784647;5051.3433253676785;5054.4692807254705;5068;5068.771905264198;4836.879078023077;4891.779869905791;4895.4859739728245;4902.436219834622;4937.604991600591 18:32:01 INFO - PROCESS | 12981 | |1;ext.html;483.24131114150777;488.49440828742246;490.8061315780267;536.9570434365252;564.2241917363623;34263.657363426355;37969.62030379699;37971.05072373189;38043.23913521728;38262.61737382625;37804.62195378046;38414.61585384145;38430.61569384305;38555;38625.227495450075;7374.336309732136;9094.86357704635;9526.380785248972;9535.570899309549;9729.318947673666;9327.113924177227;9409.52952352383;9432.952835235814;9435.19800816928;9438;9271.072892710743;9475.62097516102;9502.097300756452;9523.71428857132;9531.666391676292;9343.626254949793;9369.812603747921;9378.155965963062;9386.296027797942;9448.763780905463;9261.305402094802;9337.393069450532;9357.859632105525;9391.436513809193;9412.811743765154;33659.6634033659;33675;33880.49179262313;33885.661143388745;33989.150271243416;3110;3149.6062992125985;3199.23218427578;3210.341879914612;3212.646608873022;24696;24733.381665458328;24879;25241.873790631114;25363.492730145477;2782.7912906531888;2919.678835328112;2987.1038688393396;3000.8649610767347;3008.9919876841286;235768;236555;237994.81002594877;238312;238383;39635.441924178514;40698;43742.781286094;45200.321995170096;45711.771441142584;49083.50916490861;49545.75227123914;49601;49832.501674982785;49965.25052124221;11611.187216894736;11830;11833.171677982631;11841.111916606289;11872.584459543874;9080.8637870432;9212.447253164832;9229.169374756304;9279.304052195977;9323.20752736025;15644.765328520081;15737;15866.9206653966;15903.920480397524;15906.840931590536;6415.294317625057;6437.678116094176;6450.903236451457;6485.789534180611;6501.366946386721;765.8353454007304;766.2108028730416;788.0212844944932;796.6295672512309;801.6432687454144;26158.6076208857;26491.205263842116;26614.6007809883;26615.866920665274;26623.46753064928;916.6654171227455;934.7709811096189;942.7407462947745;942.7454587261401;943.1841457139525;13185.274809885548;14045.157290562598;14103;14122.788158177636;14194.432222710975;304261;307204;307476;308192;309464;47487.76256118697;47815;47998.28002579964;48218.27672584914;48390;1189.7912013965424;1213.168979249217;1224.785662509075;1229.3361584744316;1240.8821161989597;24740;25604.183539810234;26167.607485887347;26217.34456638523;26429.77123660205;41012.58987410207;41840.3723944135;41979.58020419757;42308.36537452002;42313.153736925706;254279;258285;258506;258733;259659;24282.635760463254;37906.8104659486;39479.21041579095;39878.40182397208;40024.599754003255;39019.804900975316;40406.1918761629;40632.59367406288;42242;42401.78799105985;33003.83498082494;34576.135596610286;34823.47764783581;35732.285354292246;35849.283014339046;34956.650433496354;35281.1179720509;35306.470402943465;35935.28129437449;36070.8196459016;33139.83430082834;33675.15812104619;33732.49401258934;33874.49188262227;34648.65351346555;30084.398312034074;33518;33533.83233083819;33676.663233367355;33868.3226335467;24811.751882480945;24873.502529949663;24994.50010999806;25424.745752542236;25467.36331591725 18:32:01 INFO - PROCESS | 12981 | |2;jquery.html;374.2440270653279;378.57599488572805;383.47655450310333;393.23123293960276;412.40613516536183;16148.757768633464;17124.48626541206;17876.64246715065;17895.463136105936;18105.094745262733;17509;17625.55936101598;17775.20011599478;17992;18036.27854885803;5043.193089105744;5140.845774626749;5171.043356978952;5190.325257716491;5190.403103643072;5043.5208655177885;5090.720010399426;5414.702191379472;5442.074847275952;5513.9448605514035;5485.067538518461;5498.092814685592;5519.862003449905;5551.417101204376;5552.888942221153;5440.374356948962;6015.669138197398;6016.969915150396;6017.879642407149;6027.09593560965;5173.922391164136;5336.279602253724;5352.812651557177;5356.276902618175;5371.14061750122;12474.50101995919;15295.235238238154;19909.10409031597;20411.183552657876;20415.591688166303;2392.97607023931;2393.0906255622754;2394.724606670238;2445.08309383981;2488.8755562222;9177.408387228084;9245.259512122153;9265.953670231605;9606.90393096067;9731.756706082333;1583.809942806859;1599.872010239178;1618.700540400018;1619.7408414653717;1686.0810858082252;72289.63855180742;72809.63595182043;73569;73933.63033184853;75003;10016.749581260527;10094.444805535766;10133.2906696532;10149.949250253849;10387.272890897715;13483.258420786951;13522.25627590492;13536.932315338361;13596.320183990762;13617.931910340583;6423.293437721847;6620.9006864897065;6628.867422651617;6753.324667533306;6775.525713200127;5849.298084229835;5927.73325200367;6112.144299798032;6114.174586430864;6145.293291271471;4442.955570444319;4478.2386994211065;4499.167653984024;4522.1181869535785;4583.289590113471;1873.571364403139;1892.2052737850136;1897.7438045863908;1949.9415017549495;1952.5509132899228;768.7962689887185;796.9880451793227;800.9216084261333;811.8619834628128;823.8022874510194;16341.42805001843;16493.09287989172;16502.75245871313;16834.32662693503;17626.64746705059;777.6034222546542;784.2157842157842;784.3293983644016;791.1495142721598;814.1532805881817;9090.457552698994;9150.86273705895;9494.430334179971;9662.806743865223;9735.367201131903;421436;423318;425294;433786;440654;84499;88522.55738721266;88974;89637;89754;866.6143566113145;876.640577363278;900.8333458310234;926.6108234541643;930.4835816121982;15260.694786103993;16208.351665933702;16276.918615406847;16646.66706665884;17005.979641221566;39026;39363.80318098391;39499.65503794523;39925.2014959705;40409;52217.43347699575;54133.45866541284;54242.728786355816;54993;55408.72295638496;6878.621675807879;7774.3003129716335;7937.166597507409;7937.777422321759;8066.637001334837;11401.657950261506;12082.637520874388;12179.391030448265;12202.206856554296;13024.892884104578;9384.436933783994;9562.569684364082;9690.418574885529;9720.27097967641;10424.113950314308;10315.12321452685;10408.635697750542;10558.472076396303;10693.518791654238;10872.130229581773;10042.69871903844;10054.54754536033;10134.138598218939;10284.742881427725;10419.479026048819;7329.230430804689;7347.302006309392;7349.889751653836;7525.720627493449;7535.284148005931;9469.14777670013;9702;9733.513324333897;9783.41299522031;9979.401235925867 18:32:01 INFO - PROCESS | 12981 | |3;mootools.html;1314.8093526438668;1330.8469526004505;1353.2895230004247;1354.7764618837891;1356.5591182865571;7358.779236622897;7505.399568034558;7634.770956871303;7709.768706938794;7771.222877712226;7523.4357423193205;7817.843643127134;7831.960840195791;7833.099193592739;7838.25536574026;2140.7752186020475;2145.3885642591863;2160.459885028743;2164.1235299703644;2166.274298110135;2095.2038225474375;2139.732533433321;2144.5603651251454;2147.334326358826;2155.008695999842;2051.2205361962433;2061.762897266811;2084.405944305873;2094.3193462124796;2096.6330892093897;2095.528506086134;2101.957960840775;2122.9256976005845;2131.030381176561;2138.7540432850187;1755.736639504072;1803.7114061750187;2020.3938818354582;2088.6240476714183;2129.2547608337113;7457.328840404335;7624.504407213513;7708.49894756839;7852.586534423802;7861.606919653995;4490.842820501267;4619.284010978304;4625.560571745713;4626.1210370029585;4635.397398338195;2889.1765846733792;2919.095080525044;2937.8824847006094;2980.92686632812;2992.895248666286;1047.3140093238865;1057.8254587992972;1090.8800031996554;1097.9890201098046;1118.3960661242918;9739.756506087404;9826.557804898797;9842.11420972116;9928.80142397148;9935.205183585296;3836.769793812324;4006.939895901564;4046.9595304046584;4109.363048727452;4144.585541445831;8000.959995199987;8071.515709057476;8086.636101375452;8086.676532938616;8094.595270236582;4557.680962332671;4574.473935497461;4595.333676616872;4599.448066232074;4603.470600880874;4150.294449943517;4203.600657937491;4330.58859408362;4369.934450983238;4380.824767009348;3451.8446669899913;3496.9650303497147;3544.7164226861787;3590.79708297718;3598.6581274778855;1030.4332617060736;1032.746976990642;1053.6259627832162;1058.8517607534952;1059.0838924330399;707.169076335304;727.6107282603782;742.7177672484421;749.7113611259705;774.9108852481924;4556.544345565483;4707.105649926503;4853.053654537332;4916.582090522345;4960.0327936052845;472.3505180376982;493.5730593036997;500.52950226786703;503.3908970146091;507.5685667182939;2969.752703864382;2971.1977766003056;3019.667836537979;3066.647335556395;3133.417841863384;8968.551572421353;9298.395604285699;9412.011738767467;9413.57638906251;9497.050294970448;9177;9206.677766278148;9309.115634014757;9396.201322887495;9403;6679.332066793282;6924.549904256207;6946.0622815920215;6975.267596902354;7000.299970002959;4703.3885594872445;4725.149473094876;4766.261229509431;4775.140474714584;4854.320395144753;8236.382271329554;8302.83394332122;8403.327733781161;8494.27798637098;8573.356998225283;8248.793780155544;8691.91308086911;8725.301975842045;8733.868991964999;8818.823623527622;6356.841078972878;6626.403623673892;6649.534532582867;6657.40083392497;6664.133662623828;7269.563826170447;7343.669534871051;7359.632018398952;7399.963000184965;7498.287662672037;6634.104395906491;6666.300038495888;6677.198736151693;6727.764528241488;6753.189617245962;6522.934770652233;6542.476601871744;6559.836004099745;6568.080468734476;6576;5990.221271234712;6038.184845045863;6071;6077.787277445268;6105.389461053859;4216.451861258017;4265.2749032663905;4280.400743895795;4304.763238021939;4430.756308403069;4174.311238645711;4174.3321068628875;4246.193223287565;4330.5236423993965;4407.471103467605 18:32:01 INFO - PROCESS | 12981 | |4;prototype.html;339.9286149908519;362.84216365880843;366.8147585469338;377.8809674952388;380.6440977685864;4651.9302210466785;4795.784189711462;4910.4843991380885;5028.522290382417;5043.36957880265;4786.377770889788;4829.589484893788;4858.125537403266;4954.380702412199;4971.502849715027;3940.8620698275568;3963.564007959122;3976.940345894814;3979.880603581897;4016.678665706751;3889.591592882749;3962.5839286874893;3970.50368703912;3981.701372397067;4035.273650742865;3914.8434062637602;3916.158026024404;3935.685145188392;3946.3883098119836;3947.7039222058315;3882.320593896085;3939.0349364405615;3942.5215544170937;3960.9009774755573;3976.6818654507715;3606.1525541497726;3613.717130418716;3617.927641447183;3621.203335266237;3633.6003039665616;4576.26779715244;4694.57748802606;4776.9761151194025;4799.256115302133;4839.540243676845;4447;4452.755098469583;4482.78964679538;4485.147821913859;4565.817367305303;5039.370078740158;5143.122760192503;5158.974205128988;5183.170692689189;5235.450277720861;3706.4069748840056;3746.831392587313;3887.1836914248042;3915.725899187058;3931.253061918226;5195.220716892459;5206.817761378334;5334.173203153478;5356.91964620531;5371.677699338014;3626.7850270159265;3692.464592634107;3714.0714821294678;3762.8711386583914;3781.3949768036982;3714.23858109087;3735.3836616957897;3744.457053727249;3794.6774524165753;3807.58116607173;4143.96400899775;4301.2257793597455;4302.7633480158265;4317.654587632982;4359.433273674465;5035.949640503622;5050.84847454577;5060.760113772149;5139.563137133311;5190.506901844319;1220.072285788452;1251.1304643272838;1257.823934621114;1263.2420547671506;1263.8766871655523;808.6118663041773;859.7979474823411;860.5783166248493;889.3418870036127;893.2139717048956;4246.214450326699;4273.7008409411665;4276.5295817460055;4323.740575565476;4363.323684828857;4969.943484756921;5020.799168033311;5064.1897296433135;5066.82266120684;5098.133317336062;4277.529471758104;4292.939389093252;4318.5681431856565;4328.511106113997;4365.825366985348;2463.224084413404;2635.235781623346;2635.2884721125574;2687.951698837455;2712.416830381438;4717.315989181549;4728.40894888139;4735.266033764772;4776.5701086902345;4806.711597304173;4775.546323099369;5068.898622027613;5152.892128192457;5198.532132108053;5240.68555886648;4686.39076920005;4710.411198600175;4737.313089601988;4762.571368576845;4773.570378665937;4979.825706100269;4980.775865086152;5008.197049062262;5127.512886275797;5129.717865517432;4622.745748983838;4863.465018847854;4916.311716359641;4989.775460104376;5033.395992480926;4715.457722361835;4719.315699223662;4783.95216047835;4953.23224900141;4994.525520075587;3682.7237957153857;3685.783691381891;3726.9191934338737;3752.6434988676033;3757.887263382103;5187.610929180402;5253.50091741284;5308.442613525524;5320.787168513216;5376.865578360573;4922.064807686528;5088.6946783193125;5098.745062746773;5155;5218.321618189763;4967.925481117713;5130.769115389891;5135.589152867687;5159.535641792257;5167.638265321541;4962.404511458648;4991.101601711727;4998.850724043829;5038.84883453497;5062.215356619729;5070.2141168119;5086.848635235732;5096.038025360189;5153.665011774373;5161.948380516297;4984.576311013604;5016.924746128884;5031.52200540948;5040.344755181803;5057.7724002419245 18:32:01 INFO - PROCESS | 12981 | |5;yui.html;627.3068259573168;637.9298277189505;718.3570704219724;726.476936605644;727.1564984617844;12048.457819398127;12499.812502812465;12868.806967895478;12941.870581294184;12995.610131696052;12964.286964216964;13044.08691391603;13065;13108.082434229607;13137.60587182386;793.1909452358606;801.7795106345743;806.3629732511309;806.7418426103649;810.2869474862113;782.3232903538427;804.3926835239386;808.2119933065273;809.9433039687224;819.4264015189361;840.5797101449275;843.0052538005182;844.2992316377392;845.471580262336;845.4927043773748;828.5815663090161;829.1335554345724;834.0366876257932;836.6778790165769;838.1869586501084;617.6355949989482;618.8731310081422;619.3775255867824;621.0652967284253;622.2657264427974;12887.871121288761;13096.803547946789;13767.655808604764;13943.16341019542;13963.720725585534;11681.649550513499;11910.106741994385;11957.641270761804;12118.939405302917;12151.756964860742;10378.273520853543;10379.584816607327;10385.63650272237;10462.843057354146;10479.423631700254;3079.4303053935096;3119.313750974782;3130.624325081005;3137.294108825519;3139.7331226845745;34174.82912585421;40915;42961.35557966633;52006.47993520054;57925;9857;10025.799484010278;10070.798584028278;10252.282340236261;10321.793564128826;18116.456506304832;18517.722234166496;18710.158042888103;18733.81266187348;19031;6076.75692972285;6103.84740381494;6202.162708034358;6208.255009398901;6267.655278959701;3212.4699424595146;3228.9838550807094;3259.4947783093658;3304.2069903223055;3354.111160542458;2812.7187281272118;2861.141657502741;2872.5834753960976;2900.8549572521288;2910.839903805311;509.28699820251205;518.7898900945123;526.1397614899666;528.4952870009132;535.2586667465588;559.420999265758;590.3889474394067;591.8845825064158;599.2509363295881;606.6723969056749;7979.202079791974;8170.83658326842;8203.261706446448;8344.457610255315;8628.568571571397;599.1851082527759;605.6850437772333;608.6378604730179;612.2652816620074;625.1654041854085;3673.5959044505084;3736.9065773355883;3969.186316805048;4373.2128216921255;4397.1865204937185;57303.42696572981;57825.710871446216;58969.115463268085;59683.403165967786;60125.699371502866;40908.79545602312;46122.308165377544;48239;52890.47109528932;53405.465945340824;44066.33900491495;45384.54615453869;53006.73496632569;54849;55545.722271387574;8264.628091736007;9129.406588571721;9132.086791320815;9163.908360916306;9198;34837.65162348344;34867.9539613812;35675.89727181407;35789.82105089458;36568.45147322739;43034.35448468213;43541;43760;44509.77745111254;44544;10543.94728026355;10570.207234457293;10659.626913058006;10817;11301.321920684784;11865.991390731539;12004.279743215435;12090.637280881587;12401.875981240071;12726.363681816058;10753.354798712102;10904.400257985886;10978.341299521735;11280.435978200892;11305.378204198849;11092.722681933015;11144.387058711849;11338.773224535627;11403.144764142557;11791.29252244868;10555.841662375224;10663.41351225659;10722.51748671296;10977.780444390908;11021.173411993972;9395.306321165348;9480.762980925256;9582.972453682774;9793.46135962529;9938;8482.416875009465;8500.299940011899;9056.184943355129;9103.544822758968;9202.757627720172 18:32:01 INFO - PROCESS | 12981 | __end_tp_report 18:32:01 INFO - PROCESS | 12981 | __start_cc_report 18:32:01 INFO - PROCESS | 12981 | _x_x_mozilla_cycle_collect,378 18:32:01 INFO - PROCESS | 12981 | __end_cc_report 18:32:01 INFO - PROCESS | 12981 | __startTimestamp1486434721884__endTimestamp 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | ------- Summary: start ------- 18:32:01 INFO - PROCESS | 12981 | Number of tests: 6 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | [#0] dojo.html Cycles:165 Average:4701.65 Median:4836.88 stddev:505.32 (10.4%) stddev-sans-first:477.63 18:32:01 INFO - PROCESS | 12981 | Values: 2542.1 2556.6 2575.7 2576.9 2593.5 4694.1 4774.7 4778.7 4812.3 4819.3 4599.0 4668.1 4717.0 4829.1 4879.1 4143.4 4325.1 4420.8 4459.7 4459.8 4411.3 4418.9 4424.1 4428.6 4462.4 4276.5 4351.6 4352.1 4363.0 4365.8 4315.4 4339.6 4354.8 4355.2 4415.2 4267.6 4290.5 4357.6 4364.9 4394.7 4578.8 4623.7 4651.8 4743.3 4751.4 5092.8 5108.7 5145.9 5177.8 5189.5 5147.3 5159.0 5162.0 5174.3 5211.7 4593.7 4808.5 4819.7 4820.0 4843.6 5052.7 5102.3 5116.9 5136.2 5180.0 4904.1 4948.5 4979.2 4987.7 4998.1 5074.9 5102.3 5107.4 5129.2 5134.0 4914.2 4961.7 4989.5 5007.3 5036.2 4937.5 5082.5 5126.6 5129.3 5182.7 4416.4 4426.5 4428.6 4433.5 4457.4 3762.9 3813.1 3815.2 3817.5 3845.4 4220.9 4253.3 4299.3 4382.5 4382.5 5001.2 5078.2 5095.5 5106.9 5131.5 4393.3 4414.8 4423.0 4437.1 4438.5 4418.8 4537.8 4557.5 4558.6 4562.0 4793.9 4832.3 4836.1 4859.1 4862.2 5140.2 5143.6 5145.1 5152.8 5172.6 4665.7 4706.2 4724.2 4748.7 4822.2 4960.6 4973.3 4990.1 4992.3 5006.2 5005.9 5028.3 5047.5 5053.8 5129.9 5021.8 5028.4 5029.9 5056.7 5057.7 5007.0 5015.9 5020.0 5024.6 5048.3 4758.4 4851.4 4909.0 4916.5 4976.5 4981.3 5051.3 5054.5 5068.0 5068.8 4836.9 4891.8 4895.5 4902.4 4937.6 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | [#1] ext.html Cycles:180 Average:42354.68 Median:36003.05 stddev:70245.52 (195.1%) stddev-sans-first:70372.22 18:32:01 INFO - PROCESS | 12981 | Values: 483.2 488.5 490.8 537.0 564.2 34263.7 37969.6 37971.1 38043.2 38262.6 37804.6 38414.6 38430.6 38555.0 38625.2 7374.3 9094.9 9526.4 9535.6 9729.3 9327.1 9409.5 9433.0 9435.2 9438.0 9271.1 9475.6 9502.1 9523.7 9531.7 9343.6 9369.8 9378.2 9386.3 9448.8 9261.3 9337.4 9357.9 9391.4 9412.8 33659.7 33675.0 33880.5 33885.7 33989.2 3110.0 3149.6 3199.2 3210.3 3212.6 24696.0 24733.4 24879.0 25241.9 25363.5 2782.8 2919.7 2987.1 3000.9 3009.0 235768.0 236555.0 237994.8 238312.0 238383.0 39635.4 40698.0 43742.8 45200.3 45711.8 49083.5 49545.8 49601.0 49832.5 49965.3 11611.2 11830.0 11833.2 11841.1 11872.6 9080.9 9212.4 9229.2 9279.3 9323.2 15644.8 15737.0 15866.9 15903.9 15906.8 6415.3 6437.7 6450.9 6485.8 6501.4 765.8 766.2 788.0 796.6 801.6 26158.6 26491.2 26614.6 26615.9 26623.5 916.7 934.8 942.7 942.7 943.2 13185.3 14045.2 14103.0 14122.8 14194.4 304261.0 307204.0 307476.0 308192.0 309464.0 47487.8 47815.0 47998.3 48218.3 48390.0 1189.8 1213.2 1224.8 1229.3 1240.9 24740.0 25604.2 26167.6 26217.3 26429.8 41012.6 41840.4 41979.6 42308.4 42313.2 254279.0 258285.0 258506.0 258733.0 259659.0 24282.6 37906.8 39479.2 39878.4 40024.6 39019.8 40406.2 40632.6 42242.0 42401.8 33003.8 34576.1 34823.5 35732.3 35849.3 34956.7 35281.1 35306.5 35935.3 36070.8 33139.8 33675.2 33732.5 33874.5 34648.7 30084.4 33518.0 33533.8 33676.7 33868.3 24811.8 24873.5 24994.5 25424.7 25467.4 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | [#2] jquery.html Cycles:180 Average:25938.96 Median:5172.48 stddev:70983.72 (1372.3%) stddev-sans-first:71156.90 18:32:01 INFO - PROCESS | 12981 | Values: 374.2 378.6 383.5 393.2 412.4 16148.8 17124.5 17876.6 17895.5 18105.1 17509.0 17625.6 17775.2 17992.0 18036.3 5043.2 5140.8 5171.0 5190.3 5190.4 5043.5 5090.7 5414.7 5442.1 5513.9 5485.1 5498.1 5519.9 5551.4 5552.9 5440.4 6015.7 6017.0 6017.9 6027.1 5173.9 5336.3 5352.8 5356.3 5371.1 12474.5 15295.2 19909.1 20411.2 20415.6 2393.0 2393.1 2394.7 2445.1 2488.9 9177.4 9245.3 9266.0 9606.9 9731.8 1583.8 1599.9 1618.7 1619.7 1686.1 72289.6 72809.6 73569.0 73933.6 75003.0 10016.7 10094.4 10133.3 10149.9 10387.3 13483.3 13522.3 13536.9 13596.3 13617.9 6423.3 6620.9 6628.9 6753.3 6775.5 5849.3 5927.7 6112.1 6114.2 6145.3 4443.0 4478.2 4499.2 4522.1 4583.3 1873.6 1892.2 1897.7 1949.9 1952.6 768.8 797.0 800.9 811.9 823.8 16341.4 16493.1 16502.8 16834.3 17626.6 777.6 784.2 784.3 791.1 814.2 9090.5 9150.9 9494.4 9662.8 9735.4 421436.0 423318.0 425294.0 433786.0 440654.0 84499.0 88522.6 88974.0 89637.0 89754.0 866.6 876.6 900.8 926.6 930.5 15260.7 16208.4 16276.9 16646.7 17006.0 39026.0 39363.8 39499.7 39925.2 40409.0 52217.4 54133.5 54242.7 54993.0 55408.7 6878.6 7774.3 7937.2 7937.8 8066.6 11401.7 12082.6 12179.4 12202.2 13024.9 9384.4 9562.6 9690.4 9720.3 10424.1 10315.1 10408.6 10558.5 10693.5 10872.1 10042.7 10054.5 10134.1 10284.7 10419.5 7329.2 7347.3 7349.9 7525.7 7535.3 9469.1 9702.0 9733.5 9783.4 9979.4 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | [#3] mootools.html Cycles:180 Average:4920.03 Median:4770.70 stddev:2762.62 (57.9%) stddev-sans-first:2757.09 18:32:01 INFO - PROCESS | 12981 | Values: 1314.8 1330.8 1353.3 1354.8 1356.6 7358.8 7505.4 7634.8 7709.8 7771.2 7523.4 7817.8 7832.0 7833.1 7838.3 2140.8 2145.4 2160.5 2164.1 2166.3 2095.2 2139.7 2144.6 2147.3 2155.0 2051.2 2061.8 2084.4 2094.3 2096.6 2095.5 2102.0 2122.9 2131.0 2138.8 1755.7 1803.7 2020.4 2088.6 2129.3 7457.3 7624.5 7708.5 7852.6 7861.6 4490.8 4619.3 4625.6 4626.1 4635.4 2889.2 2919.1 2937.9 2980.9 2992.9 1047.3 1057.8 1090.9 1098.0 1118.4 9739.8 9826.6 9842.1 9928.8 9935.2 3836.8 4006.9 4047.0 4109.4 4144.6 8001.0 8071.5 8086.6 8086.7 8094.6 4557.7 4574.5 4595.3 4599.4 4603.5 4150.3 4203.6 4330.6 4369.9 4380.8 3451.8 3497.0 3544.7 3590.8 3598.7 1030.4 1032.7 1053.6 1058.9 1059.1 707.2 727.6 742.7 749.7 774.9 4556.5 4707.1 4853.1 4916.6 4960.0 472.4 493.6 500.5 503.4 507.6 2969.8 2971.2 3019.7 3066.6 3133.4 8968.6 9298.4 9412.0 9413.6 9497.1 9177.0 9206.7 9309.1 9396.2 9403.0 6679.3 6924.5 6946.1 6975.3 7000.3 4703.4 4725.1 4766.3 4775.1 4854.3 8236.4 8302.8 8403.3 8494.3 8573.4 8248.8 8691.9 8725.3 8733.9 8818.8 6356.8 6626.4 6649.5 6657.4 6664.1 7269.6 7343.7 7359.6 7400.0 7498.3 6634.1 6666.3 6677.2 6727.8 6753.2 6522.9 6542.5 6559.8 6568.1 6576.0 5990.2 6038.2 6071.0 6077.8 6105.4 4216.5 4265.3 4280.4 4304.8 4430.8 4174.3 4174.3 4246.2 4330.5 4407.5 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | [#4] prototype.html Cycles:180 Average:4223.16 Median:4736.29 stddev:1198.86 (25.3%) stddev-sans-first:1166.26 18:32:01 INFO - PROCESS | 12981 | Values: 339.9 362.8 366.8 377.9 380.6 4651.9 4795.8 4910.5 5028.5 5043.4 4786.4 4829.6 4858.1 4954.4 4971.5 3940.9 3963.6 3976.9 3979.9 4016.7 3889.6 3962.6 3970.5 3981.7 4035.3 3914.8 3916.2 3935.7 3946.4 3947.7 3882.3 3939.0 3942.5 3960.9 3976.7 3606.2 3613.7 3617.9 3621.2 3633.6 4576.3 4694.6 4777.0 4799.3 4839.5 4447.0 4452.8 4482.8 4485.1 4565.8 5039.4 5143.1 5159.0 5183.2 5235.5 3706.4 3746.8 3887.2 3915.7 3931.3 5195.2 5206.8 5334.2 5356.9 5371.7 3626.8 3692.5 3714.1 3762.9 3781.4 3714.2 3735.4 3744.5 3794.7 3807.6 4144.0 4301.2 4302.8 4317.7 4359.4 5035.9 5050.8 5060.8 5139.6 5190.5 1220.1 1251.1 1257.8 1263.2 1263.9 808.6 859.8 860.6 889.3 893.2 4246.2 4273.7 4276.5 4323.7 4363.3 4969.9 5020.8 5064.2 5066.8 5098.1 4277.5 4292.9 4318.6 4328.5 4365.8 2463.2 2635.2 2635.3 2688.0 2712.4 4717.3 4728.4 4735.3 4776.6 4806.7 4775.5 5068.9 5152.9 5198.5 5240.7 4686.4 4710.4 4737.3 4762.6 4773.6 4979.8 4980.8 5008.2 5127.5 5129.7 4622.7 4863.5 4916.3 4989.8 5033.4 4715.5 4719.3 4784.0 4953.2 4994.5 3682.7 3685.8 3726.9 3752.6 3757.9 5187.6 5253.5 5308.4 5320.8 5376.9 4922.1 5088.7 5098.7 5155.0 5218.3 4967.9 5130.8 5135.6 5159.5 5167.6 4962.4 4991.1 4998.9 5038.8 5062.2 5070.2 5086.8 5096.0 5153.7 5161.9 4984.6 5016.9 5031.5 5040.3 5057.8 18:32:01 INFO - PROCESS | 12981 | 18:32:01 INFO - PROCESS | 12981 | [#5] yui.html Cycles:180 Average:13632.73 Median:24231.76 stddev:16116.11 (66.5%) stddev-sans-first:16131.73 18:32:01 INFO - PROCESS | 12981 | Values: 627.3 637.9 718.4 726.5 727.2 12048.5 12499.8 12868.8 12941.9 12995.6 12964.3 13044.1 13065.0 13108.1 13137.6 793.2 801.8 806.4 806.7 810.3 782.3 804.4 808.2 809.9 819.4 840.6 843.0 844.3 845.5 845.5 828.6 829.1 834.0 836.7 838.2 617.6 618.9 619.4 621.1 622.3 12887.9 13096.8 13767.7 13943.2 13963.7 11681.6 11910.1 11957.6 12118.9 12151.8 10378.3 10379.6 10385.6 10462.8 10479.4 3079.4 3119.3 3130.6 3137.3 3139.7 34174.8 40915.0 42961.4 52006.5 57925.0 9857.0 10025.8 10070.8 10252.3 10321.8 18116.5 18517.7 18710.2 18733.8 19031.0 6076.8 6103.8 6202.2 6208.3 6267.7 3212.5 3229.0 3259.5 3304.2 3354.1 2812.7 2861.1 2872.6 2900.9 2910.8 509.3 518.8 526.1 528.5 535.3 559.4 590.4 591.9 599.3 606.7 7979.2 8170.8 8203.3 8344.5 8628.6 599.2 605.7 608.6 612.3 625.2 3673.6 3736.9 3969.2 4373.2 4397.2 57303.4 57825.7 58969.1 59683.4 60125.7 40908.8 46122.3 48239.0 52890.5 53405.5 44066.3 45384.5 53006.7 54849.0 55545.7 8264.6 9129.4 9132.1 9163.9 9198.0 34837.7 34868.0 35675.9 35789.8 36568.5 43034.4 43541.0 43760.0 44509.8 44544.0 10543.9 10570.2 10659.6 10817.0 11301.3 11866.0 12004.3 12090.6 12401.9 12726.4 10753.4 10904.4 10978.3 11280.4 11305.4 11092.7 11144.4 11338.8 11403.1 11791.3 10555.8 10663.4 10722.5 10977.8 11021.2 9395.3 9480.8 9583.0 9793.5 9938.0 8482.4 8500.3 9056.2 9103.5 9202.8 18:32:01 INFO - PROCESS | 12981 | -------- Summary: end -------- 18:32:01 INFO - PROCESS | 12981 | 18:32:02 INFO - TEST-INFO | 12981: exit 0 18:32:02 INFO - TEST-OK | dromaeo_css | took 1121107ms 18:32:02 INFO - TEST-START | kraken 18:32:02 INFO - operating with platform_type : linux_ 18:32:02 INFO - Initialising browser for kraken test... 18:32:02 INFO - TEST-INFO | started process 13337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5RD8qa/profile http://localhost:52676/getInfo.html) 18:32:06 INFO - PROCESS | 13337 | 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] 18:32:06 INFO - PROCESS | 13337 | __metrics Screen width/height:1600/1200 18:32:06 INFO - PROCESS | 13337 | colorDepth:24 18:32:06 INFO - PROCESS | 13337 | Browser inner width/height: 1024/697 18:32:06 INFO - PROCESS | 13337 | __metrics 18:32:07 INFO - PROCESS | 13337 | 1486434727450 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:6303:36 < canClose@browser.js:5169:12 < forceQuit@jar:file:///tmp/tmp5RD8qa/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp5RD8qa/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp5RD8qa/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp5RD8qa/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:32:07 ERROR - PROCESS | 13337 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 18:32:08 INFO - TEST-INFO | 13337: exit 0 18:32:08 INFO - Browser initialized. 18:32:08 INFO - Running cycle 1/1 for kraken test... 18:32:08 INFO - TEST-INFO | started process 13455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5RD8qa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:20 INFO - PROCESS | 13455 | RSS: Main: 159363072 18:32:20 INFO - PROCESS | 13455 | 18:32:23 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52676/tests/kraken/driver.html?testName=audio-beat-detection) 18:32:24 INFO - PROCESS | 13455 | RSS: Main: 165617664 18:32:24 INFO - PROCESS | 13455 | 18:32:27 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52676/tests/kraken/driver.html?testName=audio-dft) 18:32:27 INFO - PROCESS | 13455 | RSS: Main: 164749312 18:32:27 INFO - PROCESS | 13455 | 18:32:30 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52676/tests/kraken/driver.html?testName=audio-fft) 18:32:31 INFO - PROCESS | 13455 | RSS: Main: 161648640 18:32:31 INFO - PROCESS | 13455 | 18:32:33 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52676/tests/kraken/driver.html?testName=audio-oscillator) 18:32:34 INFO - PROCESS | 13455 | RSS: Main: 162996224 18:32:34 INFO - PROCESS | 13455 | 18:32:36 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:32:37 INFO - PROCESS | 13455 | RSS: Main: 162791424 18:32:37 INFO - PROCESS | 13455 | 18:32:40 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52676/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:41 INFO - PROCESS | 13455 | RSS: Main: 167641088 18:32:41 INFO - PROCESS | 13455 | 18:32:44 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52676/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:45 INFO - PROCESS | 13455 | RSS: Main: 163606528 18:32:45 INFO - PROCESS | 13455 | 18:32:48 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52676/tests/kraken/driver.html?testName=json-parse-financial) 18:32:49 INFO - PROCESS | 13455 | RSS: Main: 165105664 18:32:49 INFO - PROCESS | 13455 | 18:32:50 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:51 INFO - PROCESS | 13455 | RSS: Main: 165101568 18:32:51 INFO - PROCESS | 13455 | 18:32:53 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:54 INFO - PROCESS | 13455 | RSS: Main: 165568512 18:32:54 INFO - PROCESS | 13455 | 18:32:56 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:56 INFO - PROCESS | 13455 | RSS: Main: 165277696 18:32:56 INFO - PROCESS | 13455 | 18:32:59 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:33:00 INFO - PROCESS | 13455 | RSS: Main: 165715968 18:33:00 INFO - PROCESS | 13455 | 18:33:03 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:33:04 INFO - PROCESS | 13455 | RSS: Main: 165646336 18:33:04 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | Cycle 1(1): loaded http://localhost:52676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52676/tests/kraken/driver.html?testName=ai-astar) 18:33:06 INFO - PROCESS | 13455 | RSS: Main: 168726528 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | __start_tp_report 18:33:06 INFO - PROCESS | 13455 | _x_x_mozilla_page_load 18:33:06 INFO - PROCESS | 13455 | _x_x_mozilla_page_load_details 18:33:06 INFO - PROCESS | 13455 | |i|pagename|runs| 18:33:06 INFO - PROCESS | 13455 | |0;ai-astar;108;120;118;117;118;116;119;119;130;128 18:33:06 INFO - PROCESS | 13455 | |1;audio-beat-detection;157;133;129;178;134;137;138;126;167;128 18:33:06 INFO - PROCESS | 13455 | |2;audio-dft;169;174;176;173;165;173;166;179;168;167 18:33:06 INFO - PROCESS | 13455 | |3;audio-fft;78;76;90;115;79;79;78;81;96;77 18:33:06 INFO - PROCESS | 13455 | |4;audio-oscillator;85;85;116;85;86;85;113;85;85;108 18:33:06 INFO - PROCESS | 13455 | |5;imaging-gaussian-blur;120;119;132;123;120;119;119;118;119;118 18:33:06 INFO - PROCESS | 13455 | |6;imaging-darkroom;160;154;151;158;152;152;152;150;151;152 18:33:06 INFO - PROCESS | 13455 | |7;imaging-desaturate;95;97;97;102;96;97;97;96;102;97 18:33:06 INFO - PROCESS | 13455 | |8;json-parse-financial;67;71;68;68;67;67;67;69;72;70 18:33:06 INFO - PROCESS | 13455 | |9;json-stringify-tinderbox;77;67;66;74;66;66;67;66;67;69 18:33:06 INFO - PROCESS | 13455 | |10;stanford-crypto-aes;95;89;88;88;106;93;89;92;98;87 18:33:06 INFO - PROCESS | 13455 | |11;stanford-crypto-ccm;140;135;137;138;149;136;152;136;185;141 18:33:06 INFO - PROCESS | 13455 | |12;stanford-crypto-pbkdf2;193;187;185;199;182;198;183;183;183;200 18:33:06 INFO - PROCESS | 13455 | |13;stanford-crypto-sha256-iterative;72;75;75;73;83;72;72;75;74;81 18:33:06 INFO - PROCESS | 13455 | __end_tp_report 18:33:06 INFO - PROCESS | 13455 | __start_cc_report 18:33:06 INFO - PROCESS | 13455 | _x_x_mozilla_cycle_collect,912 18:33:06 INFO - PROCESS | 13455 | __end_cc_report 18:33:06 INFO - PROCESS | 13455 | __startTimestamp1486434786505__endTimestamp 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | ------- Summary: start ------- 18:33:06 INFO - PROCESS | 13455 | Number of tests: 14 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#0] ai-astar Cycles:10 Average:119.30 Median:119.00 stddev:6.13 (5.2%) stddev-sans-first:4.95 18:33:06 INFO - PROCESS | 13455 | Values: 108.0 120.0 118.0 117.0 118.0 116.0 119.0 119.0 130.0 128.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:137.50 stddev:18.10 (13.2%) stddev-sans-first:18.44 18:33:06 INFO - PROCESS | 13455 | Values: 157.0 133.0 129.0 178.0 134.0 137.0 138.0 126.0 167.0 128.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#2] audio-dft Cycles:10 Average:171.00 Median:173.00 stddev:4.67 (2.7%) stddev-sans-first:4.89 18:33:06 INFO - PROCESS | 13455 | Values: 169.0 174.0 176.0 173.0 165.0 173.0 166.0 179.0 168.0 167.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#3] audio-fft Cycles:10 Average:84.90 Median:79.00 stddev:12.37 (15.7%) stddev-sans-first:12.86 18:33:06 INFO - PROCESS | 13455 | Values: 78.0 76.0 90.0 115.0 79.0 79.0 78.0 81.0 96.0 77.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:85.00 stddev:13.28 (15.6%) stddev-sans-first:13.74 18:33:06 INFO - PROCESS | 13455 | Values: 85.0 85.0 116.0 85.0 86.0 85.0 113.0 85.0 85.0 108.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#5] imaging-gaussian-blur Cycles:10 Average:120.70 Median:119.50 stddev:4.22 (3.5%) stddev-sans-first:4.47 18:33:06 INFO - PROCESS | 13455 | Values: 120.0 119.0 132.0 123.0 120.0 119.0 119.0 118.0 119.0 118.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#6] imaging-darkroom Cycles:10 Average:153.20 Median:152.00 stddev:3.26 (2.1%) stddev-sans-first:2.35 18:33:06 INFO - PROCESS | 13455 | Values: 160.0 154.0 151.0 158.0 152.0 152.0 152.0 150.0 151.0 152.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:97.00 stddev:2.41 (2.5%) stddev-sans-first:2.37 18:33:06 INFO - PROCESS | 13455 | Values: 95.0 97.0 97.0 102.0 96.0 97.0 97.0 96.0 102.0 97.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:68.50 stddev:1.84 (2.7%) stddev-sans-first:1.86 18:33:06 INFO - PROCESS | 13455 | Values: 67.0 71.0 68.0 68.0 67.0 67.0 67.0 69.0 72.0 70.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:67.00 stddev:3.87 (5.8%) stddev-sans-first:2.60 18:33:06 INFO - PROCESS | 13455 | Values: 77.0 67.0 66.0 74.0 66.0 66.0 67.0 66.0 67.0 69.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:90.50 stddev:5.91 (6.5%) stddev-sans-first:6.20 18:33:06 INFO - PROCESS | 13455 | Values: 95.0 89.0 88.0 88.0 106.0 93.0 89.0 92.0 98.0 87.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:140.50 stddev:15.21 (10.8%) stddev-sans-first:16.02 18:33:06 INFO - PROCESS | 13455 | Values: 140.0 135.0 137.0 138.0 149.0 136.0 152.0 136.0 185.0 141.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:190.00 stddev:7.41 (3.9%) stddev-sans-first:7.74 18:33:06 INFO - PROCESS | 13455 | Values: 193.0 187.0 185.0 199.0 182.0 198.0 183.0 183.0 183.0 200.0 18:33:06 INFO - PROCESS | 13455 | 18:33:06 INFO - PROCESS | 13455 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:75.00 stddev:3.82 (5.1%) stddev-sans-first:3.88 18:33:06 INFO - PROCESS | 13455 | Values: 72.0 75.0 75.0 73.0 83.0 72.0 72.0 75.0 74.0 81.0 18:33:06 INFO - PROCESS | 13455 | -------- Summary: end -------- 18:33:06 INFO - PROCESS | 13455 | 18:33:07 INFO - TEST-INFO | 13455: exit 0 18:33:07 INFO - TEST-OK | kraken | took 64906ms 18:33:07 INFO - SUITE-END | took 1186s 18:33:08 INFO - Completed test suite (00:19:46) 18:33:08 INFO - javascript benchmark 18:33:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6255.545092452915, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2542.110261408507, 2556.578164602841, 2575.7424257574244, 2576.922692319231, 2593.533164030475, 4694.108119457301, 4774.689645173065, 4778.665493415462, 4812.302216178652, 4819.325294458778, 4599.0, 4668.136394766971, 4716.952830471694, 4829.058333624945, 4879.09736698711, 4143.3784932260105, 4325.113351762889, 4420.756858372788, 4459.665525085616, 4459.799309031101, 4411.316245981862, 4418.933715994247, 4424.137293227822, 4428.6014258716705, 4462.3935383262, 4276.5295817460055, 4351.608355248011, 4352.107817897323, 4362.956370436286, 4365.7817109144735, 4315.43899293093, 4339.60943515082, 4354.7604881731495, 4355.194289056535, 4415.227335216357, 4267.615914567704, 4290.4636920384955, 4357.564243575649, 4364.912701745948, 4394.714343567658, 4578.839740609063, 4623.653226008029, 4651.790669419885, 4743.264793956942, 4751.3585665935, 5092.770825312869, 5108.693478391308, 5145.897082058338, 5177.818776342848, 5189.532942035197, 5147.279380886679, 5159.0, 5162.0, 5174.301469301634, 5211.687298762086, 4593.701409408378, 4808.495108013678, 4819.662623616313, 4820.035992801454, 4843.636727245471, 5052.747362631853, 5102.285680004802, 5116.948830511722, 5136.1525348317855, 5179.974100129475, 4904.068227036852, 4948.505149485023, 4979.228219625964, 4987.700737955734, 4998.100341938413, 5074.923876141861, 5102.285680004802, 5107.412647545506, 5129.179331306973, 5134.0, 4914.213725803926, 4961.70229786214, 4989.525995030466, 5007.298978143063, 5036.219385995177, 4937.481564435754, 5082.542571168538, 5126.564242039469, 5129.333186685782, 5182.714950677749, 4416.3596278539435, 4426.468823741107, 4428.601425871622, 4433.512313645497, 4457.398251236106, 3762.8682996095004, 3813.1420430402936, 3815.1797363566966, 3817.4846395736777, 3845.403962385835, 4220.894477638022, 4253.255680255943, 4299.269124248885, 4382.474103107584, 4382.53983331752, 5001.174806157016, 5078.21287700407, 5095.464976177522, 5106.872328191825, 5131.461196574381, 4393.29707246839, 4414.757188354672, 4423.0, 4437.134758722018, 4438.533953934855, 4418.756968366771, 4537.8411755588395, 4557.475890272594, 4558.635309175258, 4561.954380456219, 4793.9280910787065, 4832.323474713613, 4836.12949669063, 4859.1010663027455, 4862.17343051675, 5140.151874940593, 5143.6399452037995, 5145.125328694206, 5152.76812543444, 5172.612054095883, 4665.720056796603, 4706.176419126571, 4724.244120940633, 4748.667593268438, 4822.156122678447, 4960.553550180501, 4973.303737476684, 4990.076835785246, 4992.2761199626575, 5006.199008158677, 5005.949940500694, 5028.270900719302, 5047.4700156484505, 5053.823116190915, 5129.948700512947, 5021.799128034838, 5028.396592408934, 5029.9245511318095, 5056.74716264178, 5057.721825299644, 5006.9735704181285, 5015.949840501548, 5020.021095886267, 5024.648274620741, 5048.268001139888, 4758.405199350082, 4851.369321988119, 4908.993656300521, 4916.532929371704, 4976.452590215146, 4981.327520784647, 5051.3433253676785, 5054.4692807254705, 5068.0, 5068.771905264198, 4836.879078023077, 4891.779869905791, 4895.4859739728245, 4902.436219834622, 4937.604991600591], "value": 4668.0315108705645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.24131114150777, 488.49440828742246, 490.8061315780267, 536.9570434365252, 564.2241917363623, 34263.657363426355, 37969.62030379699, 37971.05072373189, 38043.23913521728, 38262.61737382625, 37804.62195378046, 38414.61585384145, 38430.61569384305, 38555.0, 38625.227495450075, 7374.336309732136, 9094.86357704635, 9526.380785248972, 9535.570899309549, 9729.318947673666, 9327.113924177227, 9409.52952352383, 9432.952835235814, 9435.19800816928, 9438.0, 9271.072892710743, 9475.62097516102, 9502.097300756452, 9523.71428857132, 9531.666391676292, 9343.626254949793, 9369.812603747921, 9378.155965963062, 9386.296027797942, 9448.763780905463, 9261.305402094802, 9337.393069450532, 9357.859632105525, 9391.436513809193, 9412.811743765154, 33659.6634033659, 33675.0, 33880.49179262313, 33885.661143388745, 33989.150271243416, 3110.0, 3149.6062992125985, 3199.23218427578, 3210.341879914612, 3212.646608873022, 24696.0, 24733.381665458328, 24879.0, 25241.873790631114, 25363.492730145477, 2782.7912906531888, 2919.678835328112, 2987.1038688393396, 3000.8649610767347, 3008.9919876841286, 235768.0, 236555.0, 237994.81002594877, 238312.0, 238383.0, 39635.441924178514, 40698.0, 43742.781286094, 45200.321995170096, 45711.771441142584, 49083.50916490861, 49545.75227123914, 49601.0, 49832.501674982785, 49965.25052124221, 11611.187216894736, 11830.0, 11833.171677982631, 11841.111916606289, 11872.584459543874, 9080.8637870432, 9212.447253164832, 9229.169374756304, 9279.304052195977, 9323.20752736025, 15644.765328520081, 15737.0, 15866.9206653966, 15903.920480397524, 15906.840931590536, 6415.294317625057, 6437.678116094176, 6450.903236451457, 6485.789534180611, 6501.366946386721, 765.8353454007304, 766.2108028730416, 788.0212844944932, 796.6295672512309, 801.6432687454144, 26158.6076208857, 26491.205263842116, 26614.6007809883, 26615.866920665274, 26623.46753064928, 916.6654171227455, 934.7709811096189, 942.7407462947745, 942.7454587261401, 943.1841457139525, 13185.274809885548, 14045.157290562598, 14103.0, 14122.788158177636, 14194.432222710975, 304261.0, 307204.0, 307476.0, 308192.0, 309464.0, 47487.76256118697, 47815.0, 47998.28002579964, 48218.27672584914, 48390.0, 1189.7912013965424, 1213.168979249217, 1224.785662509075, 1229.3361584744316, 1240.8821161989597, 24740.0, 25604.183539810234, 26167.607485887347, 26217.34456638523, 26429.77123660205, 41012.58987410207, 41840.3723944135, 41979.58020419757, 42308.36537452002, 42313.153736925706, 254279.0, 258285.0, 258506.0, 258733.0, 259659.0, 24282.635760463254, 37906.8104659486, 39479.21041579095, 39878.40182397208, 40024.599754003255, 39019.804900975316, 40406.1918761629, 40632.59367406288, 42242.0, 42401.78799105985, 33003.83498082494, 34576.135596610286, 34823.47764783581, 35732.285354292246, 35849.283014339046, 34956.650433496354, 35281.1179720509, 35306.470402943465, 35935.28129437449, 36070.8196459016, 33139.83430082834, 33675.15812104619, 33732.49401258934, 33874.49188262227, 34648.65351346555, 30084.398312034074, 33518.0, 33533.83233083819, 33676.663233367355, 33868.3226335467, 24811.751882480945, 24873.502529949663, 24994.50010999806, 25424.745752542236, 25467.36331591725], "value": 16905.269289719057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.2440270653279, 378.57599488572805, 383.47655450310333, 393.23123293960276, 412.40613516536183, 16148.757768633464, 17124.48626541206, 17876.64246715065, 17895.463136105936, 18105.094745262733, 17509.0, 17625.55936101598, 17775.20011599478, 17992.0, 18036.27854885803, 5043.193089105744, 5140.845774626749, 5171.043356978952, 5190.325257716491, 5190.403103643072, 5043.5208655177885, 5090.720010399426, 5414.702191379472, 5442.074847275952, 5513.9448605514035, 5485.067538518461, 5498.092814685592, 5519.862003449905, 5551.417101204376, 5552.888942221153, 5440.374356948962, 6015.669138197398, 6016.969915150396, 6017.879642407149, 6027.09593560965, 5173.922391164136, 5336.279602253724, 5352.812651557177, 5356.276902618175, 5371.14061750122, 12474.50101995919, 15295.235238238154, 19909.10409031597, 20411.183552657876, 20415.591688166303, 2392.97607023931, 2393.0906255622754, 2394.724606670238, 2445.08309383981, 2488.8755562222, 9177.408387228084, 9245.259512122153, 9265.953670231605, 9606.90393096067, 9731.756706082333, 1583.809942806859, 1599.872010239178, 1618.700540400018, 1619.7408414653717, 1686.0810858082252, 72289.63855180742, 72809.63595182043, 73569.0, 73933.63033184853, 75003.0, 10016.749581260527, 10094.444805535766, 10133.2906696532, 10149.949250253849, 10387.272890897715, 13483.258420786951, 13522.25627590492, 13536.932315338361, 13596.320183990762, 13617.931910340583, 6423.293437721847, 6620.9006864897065, 6628.867422651617, 6753.324667533306, 6775.525713200127, 5849.298084229835, 5927.73325200367, 6112.144299798032, 6114.174586430864, 6145.293291271471, 4442.955570444319, 4478.2386994211065, 4499.167653984024, 4522.1181869535785, 4583.289590113471, 1873.571364403139, 1892.2052737850136, 1897.7438045863908, 1949.9415017549495, 1952.5509132899228, 768.7962689887185, 796.9880451793227, 800.9216084261333, 811.8619834628128, 823.8022874510194, 16341.42805001843, 16493.09287989172, 16502.75245871313, 16834.32662693503, 17626.64746705059, 777.6034222546542, 784.2157842157842, 784.3293983644016, 791.1495142721598, 814.1532805881817, 9090.457552698994, 9150.86273705895, 9494.430334179971, 9662.806743865223, 9735.367201131903, 421436.0, 423318.0, 425294.0, 433786.0, 440654.0, 84499.0, 88522.55738721266, 88974.0, 89637.0, 89754.0, 866.6143566113145, 876.640577363278, 900.8333458310234, 926.6108234541643, 930.4835816121982, 15260.694786103993, 16208.351665933702, 16276.918615406847, 16646.66706665884, 17005.979641221566, 39026.0, 39363.80318098391, 39499.65503794523, 39925.2014959705, 40409.0, 52217.43347699575, 54133.45866541284, 54242.728786355816, 54993.0, 55408.72295638496, 6878.621675807879, 7774.3003129716335, 7937.166597507409, 7937.777422321759, 8066.637001334837, 11401.657950261506, 12082.637520874388, 12179.391030448265, 12202.206856554296, 13024.892884104578, 9384.436933783994, 9562.569684364082, 9690.418574885529, 9720.27097967641, 10424.113950314308, 10315.12321452685, 10408.635697750542, 10558.472076396303, 10693.518791654238, 10872.130229581773, 10042.69871903844, 10054.54754536033, 10134.138598218939, 10284.742881427725, 10419.479026048819, 7329.230430804689, 7347.302006309392, 7349.889751653836, 7525.720627493449, 7535.284148005931, 9469.14777670013, 9702.0, 9733.513324333897, 9783.41299522031, 9979.401235925867], "value": 8278.504566938052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.8093526438668, 1330.8469526004505, 1353.2895230004247, 1354.7764618837891, 1356.5591182865571, 7358.779236622897, 7505.399568034558, 7634.770956871303, 7709.768706938794, 7771.222877712226, 7523.4357423193205, 7817.843643127134, 7831.960840195791, 7833.099193592739, 7838.25536574026, 2140.7752186020475, 2145.3885642591863, 2160.459885028743, 2164.1235299703644, 2166.274298110135, 2095.2038225474375, 2139.732533433321, 2144.5603651251454, 2147.334326358826, 2155.008695999842, 2051.2205361962433, 2061.762897266811, 2084.405944305873, 2094.3193462124796, 2096.6330892093897, 2095.528506086134, 2101.957960840775, 2122.9256976005845, 2131.030381176561, 2138.7540432850187, 1755.736639504072, 1803.7114061750187, 2020.3938818354582, 2088.6240476714183, 2129.2547608337113, 7457.328840404335, 7624.504407213513, 7708.49894756839, 7852.586534423802, 7861.606919653995, 4490.842820501267, 4619.284010978304, 4625.560571745713, 4626.1210370029585, 4635.397398338195, 2889.1765846733792, 2919.095080525044, 2937.8824847006094, 2980.92686632812, 2992.895248666286, 1047.3140093238865, 1057.8254587992972, 1090.8800031996554, 1097.9890201098046, 1118.3960661242918, 9739.756506087404, 9826.557804898797, 9842.11420972116, 9928.80142397148, 9935.205183585296, 3836.769793812324, 4006.939895901564, 4046.9595304046584, 4109.363048727452, 4144.585541445831, 8000.959995199987, 8071.515709057476, 8086.636101375452, 8086.676532938616, 8094.595270236582, 4557.680962332671, 4574.473935497461, 4595.333676616872, 4599.448066232074, 4603.470600880874, 4150.294449943517, 4203.600657937491, 4330.58859408362, 4369.934450983238, 4380.824767009348, 3451.8446669899913, 3496.9650303497147, 3544.7164226861787, 3590.79708297718, 3598.6581274778855, 1030.4332617060736, 1032.746976990642, 1053.6259627832162, 1058.8517607534952, 1059.0838924330399, 707.169076335304, 727.6107282603782, 742.7177672484421, 749.7113611259705, 774.9108852481924, 4556.544345565483, 4707.105649926503, 4853.053654537332, 4916.582090522345, 4960.0327936052845, 472.3505180376982, 493.5730593036997, 500.52950226786703, 503.3908970146091, 507.5685667182939, 2969.752703864382, 2971.1977766003056, 3019.667836537979, 3066.647335556395, 3133.417841863384, 8968.551572421353, 9298.395604285699, 9412.011738767467, 9413.57638906251, 9497.050294970448, 9177.0, 9206.677766278148, 9309.115634014757, 9396.201322887495, 9403.0, 6679.332066793282, 6924.549904256207, 6946.0622815920215, 6975.267596902354, 7000.299970002959, 4703.3885594872445, 4725.149473094876, 4766.261229509431, 4775.140474714584, 4854.320395144753, 8236.382271329554, 8302.83394332122, 8403.327733781161, 8494.27798637098, 8573.356998225283, 8248.793780155544, 8691.91308086911, 8725.301975842045, 8733.868991964999, 8818.823623527622, 6356.841078972878, 6626.403623673892, 6649.534532582867, 6657.40083392497, 6664.133662623828, 7269.563826170447, 7343.669534871051, 7359.632018398952, 7399.963000184965, 7498.287662672037, 6634.104395906491, 6666.300038495888, 6677.198736151693, 6727.764528241488, 6753.189617245962, 6522.934770652233, 6542.476601871744, 6559.836004099745, 6568.080468734476, 6576.0, 5990.221271234712, 6038.184845045863, 6071.0, 6077.787277445268, 6105.389461053859, 4216.451861258017, 4265.2749032663905, 4280.400743895795, 4304.763238021939, 4430.756308403069, 4174.311238645711, 4174.3321068628875, 4246.193223287565, 4330.5236423993965, 4407.471103467605], "value": 3914.7680448676056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.9286149908519, 362.84216365880843, 366.8147585469338, 377.8809674952388, 380.6440977685864, 4651.9302210466785, 4795.784189711462, 4910.4843991380885, 5028.522290382417, 5043.36957880265, 4786.377770889788, 4829.589484893788, 4858.125537403266, 4954.380702412199, 4971.502849715027, 3940.8620698275568, 3963.564007959122, 3976.940345894814, 3979.880603581897, 4016.678665706751, 3889.591592882749, 3962.5839286874893, 3970.50368703912, 3981.701372397067, 4035.273650742865, 3914.8434062637602, 3916.158026024404, 3935.685145188392, 3946.3883098119836, 3947.7039222058315, 3882.320593896085, 3939.0349364405615, 3942.5215544170937, 3960.9009774755573, 3976.6818654507715, 3606.1525541497726, 3613.717130418716, 3617.927641447183, 3621.203335266237, 3633.6003039665616, 4576.26779715244, 4694.57748802606, 4776.9761151194025, 4799.256115302133, 4839.540243676845, 4447.0, 4452.755098469583, 4482.78964679538, 4485.147821913859, 4565.817367305303, 5039.370078740158, 5143.122760192503, 5158.974205128988, 5183.170692689189, 5235.450277720861, 3706.4069748840056, 3746.831392587313, 3887.1836914248042, 3915.725899187058, 3931.253061918226, 5195.220716892459, 5206.817761378334, 5334.173203153478, 5356.91964620531, 5371.677699338014, 3626.7850270159265, 3692.464592634107, 3714.0714821294678, 3762.8711386583914, 3781.3949768036982, 3714.23858109087, 3735.3836616957897, 3744.457053727249, 3794.6774524165753, 3807.58116607173, 4143.96400899775, 4301.2257793597455, 4302.7633480158265, 4317.654587632982, 4359.433273674465, 5035.949640503622, 5050.84847454577, 5060.760113772149, 5139.563137133311, 5190.506901844319, 1220.072285788452, 1251.1304643272838, 1257.823934621114, 1263.2420547671506, 1263.8766871655523, 808.6118663041773, 859.7979474823411, 860.5783166248493, 889.3418870036127, 893.2139717048956, 4246.214450326699, 4273.7008409411665, 4276.5295817460055, 4323.740575565476, 4363.323684828857, 4969.943484756921, 5020.799168033311, 5064.1897296433135, 5066.82266120684, 5098.133317336062, 4277.529471758104, 4292.939389093252, 4318.5681431856565, 4328.511106113997, 4365.825366985348, 2463.224084413404, 2635.235781623346, 2635.2884721125574, 2687.951698837455, 2712.416830381438, 4717.315989181549, 4728.40894888139, 4735.266033764772, 4776.5701086902345, 4806.711597304173, 4775.546323099369, 5068.898622027613, 5152.892128192457, 5198.532132108053, 5240.68555886648, 4686.39076920005, 4710.411198600175, 4737.313089601988, 4762.571368576845, 4773.570378665937, 4979.825706100269, 4980.775865086152, 5008.197049062262, 5127.512886275797, 5129.717865517432, 4622.745748983838, 4863.465018847854, 4916.311716359641, 4989.775460104376, 5033.395992480926, 4715.457722361835, 4719.315699223662, 4783.95216047835, 4953.23224900141, 4994.525520075587, 3682.7237957153857, 3685.783691381891, 3726.9191934338737, 3752.6434988676033, 3757.887263382103, 5187.610929180402, 5253.50091741284, 5308.442613525524, 5320.787168513216, 5376.865578360573, 4922.064807686528, 5088.6946783193125, 5098.745062746773, 5155.0, 5218.321618189763, 4967.925481117713, 5130.769115389891, 5135.589152867687, 5159.535641792257, 5167.638265321541, 4962.404511458648, 4991.101601711727, 4998.850724043829, 5038.84883453497, 5062.215356619729, 5070.2141168119, 5086.848635235732, 5096.038025360189, 5153.665011774373, 5161.948380516297, 4984.576311013604, 5016.924746128884, 5031.52200540948, 5040.344755181803, 5057.7724002419245], "value": 3855.2158546608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.3068259573168, 637.9298277189505, 718.3570704219724, 726.476936605644, 727.1564984617844, 12048.457819398127, 12499.812502812465, 12868.806967895478, 12941.870581294184, 12995.610131696052, 12964.286964216964, 13044.08691391603, 13065.0, 13108.082434229607, 13137.60587182386, 793.1909452358606, 801.7795106345743, 806.3629732511309, 806.7418426103649, 810.2869474862113, 782.3232903538427, 804.3926835239386, 808.2119933065273, 809.9433039687224, 819.4264015189361, 840.5797101449275, 843.0052538005182, 844.2992316377392, 845.471580262336, 845.4927043773748, 828.5815663090161, 829.1335554345724, 834.0366876257932, 836.6778790165769, 838.1869586501084, 617.6355949989482, 618.8731310081422, 619.3775255867824, 621.0652967284253, 622.2657264427974, 12887.871121288761, 13096.803547946789, 13767.655808604764, 13943.16341019542, 13963.720725585534, 11681.649550513499, 11910.106741994385, 11957.641270761804, 12118.939405302917, 12151.756964860742, 10378.273520853543, 10379.584816607327, 10385.63650272237, 10462.843057354146, 10479.423631700254, 3079.4303053935096, 3119.313750974782, 3130.624325081005, 3137.294108825519, 3139.7331226845745, 34174.82912585421, 40915.0, 42961.35557966633, 52006.47993520054, 57925.0, 9857.0, 10025.799484010278, 10070.798584028278, 10252.282340236261, 10321.793564128826, 18116.456506304832, 18517.722234166496, 18710.158042888103, 18733.81266187348, 19031.0, 6076.75692972285, 6103.84740381494, 6202.162708034358, 6208.255009398901, 6267.655278959701, 3212.4699424595146, 3228.9838550807094, 3259.4947783093658, 3304.2069903223055, 3354.111160542458, 2812.7187281272118, 2861.141657502741, 2872.5834753960976, 2900.8549572521288, 2910.839903805311, 509.28699820251205, 518.7898900945123, 526.1397614899666, 528.4952870009132, 535.2586667465588, 559.420999265758, 590.3889474394067, 591.8845825064158, 599.2509363295881, 606.6723969056749, 7979.202079791974, 8170.83658326842, 8203.261706446448, 8344.457610255315, 8628.568571571397, 599.1851082527759, 605.6850437772333, 608.6378604730179, 612.2652816620074, 625.1654041854085, 3673.5959044505084, 3736.9065773355883, 3969.186316805048, 4373.2128216921255, 4397.1865204937185, 57303.42696572981, 57825.710871446216, 58969.115463268085, 59683.403165967786, 60125.699371502866, 40908.79545602312, 46122.308165377544, 48239.0, 52890.47109528932, 53405.465945340824, 44066.33900491495, 45384.54615453869, 53006.73496632569, 54849.0, 55545.722271387574, 8264.628091736007, 9129.406588571721, 9132.086791320815, 9163.908360916306, 9198.0, 34837.65162348344, 34867.9539613812, 35675.89727181407, 35789.82105089458, 36568.45147322739, 43034.35448468213, 43541.0, 43760.0, 44509.77745111254, 44544.0, 10543.94728026355, 10570.207234457293, 10659.626913058006, 10817.0, 11301.321920684784, 11865.991390731539, 12004.279743215435, 12090.637280881587, 12401.875981240071, 12726.363681816058, 10753.354798712102, 10904.400257985886, 10978.341299521735, 11280.435978200892, 11305.378204198849, 11092.722681933015, 11144.387058711849, 11338.773224535627, 11403.144764142557, 11791.29252244868, 10555.841662375224, 10663.41351225659, 10722.51748671296, 10977.780444390908, 11021.173411993972, 9395.306321165348, 9480.762980925256, 9582.972453682774, 9793.46135962529, 9938.0, 8482.416875009465, 8500.299940011899, 9056.184943355129, 9103.544822758968, 9202.757627720172], "value": 6076.853710936501, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 120.0, 118.0, 117.0, 118.0, 116.0, 119.0, 119.0, 130.0, 128.0], "value": 119.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 133.0, 129.0, 178.0, 134.0, 137.0, 138.0, 126.0, 167.0, 128.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 176.0, 173.0, 165.0, 173.0, 166.0, 179.0, 168.0, 167.0], "value": 171.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 90.0, 115.0, 79.0, 79.0, 78.0, 81.0, 96.0, 77.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 86.0, 85.0, 113.0, 85.0, 85.0, 108.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 132.0, 123.0, 120.0, 119.0, 119.0, 118.0, 119.0, 118.0], "value": 120.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 154.0, 151.0, 158.0, 152.0, 152.0, 152.0, 150.0, 151.0, 152.0], "value": 153.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 102.0, 96.0, 97.0, 97.0, 96.0, 102.0, 97.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 68.0, 67.0, 67.0, 67.0, 69.0, 72.0, 70.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 67.0, 66.0, 74.0, 66.0, 66.0, 67.0, 66.0, 67.0, 69.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 89.0, 88.0, 88.0, 106.0, 93.0, 89.0, 92.0, 98.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 137.0, 138.0, 149.0, 136.0, 152.0, 136.0, 185.0, 141.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 187.0, 185.0, 199.0, 182.0, 198.0, 183.0, 183.0, 183.0, 200.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 75.0, 73.0, 83.0, 72.0, 72.0, 75.0, 74.0, 81.0], "value": 75.2, "unit": "score"}]}]} 18:33:08 INFO - Return code: 0 18:33:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:33:08 ERROR - # TBPL SUCCESS # 18:33:08 INFO - Running post-action listener: _resource_record_post_action 18:33:08 INFO - [mozharness: 2017-02-07 02:33:08.273957Z] Finished run-tests step (success) 18:33:08 INFO - Running post-run listener: _resource_record_post_run 18:33:08 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399806464; Read time: 4; Write time: 273176 18:33:08 INFO - TinderboxPrint: CPU usage
13.5% 18:33:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 18:33:08 INFO - TinderboxPrint: I/O write bytes / time
399,806,464 / 273,176 18:33:08 INFO - TinderboxPrint: CPU idle
8,300.7 (86.5%) 18:33:08 INFO - TinderboxPrint: CPU user
1,237.4 (12.9%) 18:33:08 INFO - TinderboxPrint: Swap in / out
0 / 0 18:33:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100192256; Read time: 0; Write time: 89004 18:33:08 INFO - run-tests - Wall time: 1187s; CPU: 14.0%; Read bytes: 0; Write bytes: 299614208; Read time: 0; Write time: 184172 18:33:08 INFO - Running post-run listener: _upload_blobber_files 18:33:08 INFO - Blob upload gear active. 18:33:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:33:08 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 18:33:08 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'] 18:33:08 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 18:33:09 INFO - (blobuploader) - INFO - Open directory for files ... 18:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:10 INFO - (blobuploader) - INFO - Done attempting. 18:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:33:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:11 INFO - (blobuploader) - INFO - Done attempting. 18:33:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:33:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:33:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:14 INFO - (blobuploader) - INFO - Done attempting. 18:33:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:33:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:33:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:15 INFO - (blobuploader) - INFO - Done attempting. 18:33:15 INFO - (blobuploader) - INFO - Iteration through files over. 18:33:15 INFO - Return code: 0 18:33:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:33:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:33:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c440f47151593af70be5b554ca4ef06537567515f14a5ecd042e0e926df4cc3e696a50a4674b211235cceb9943776a15ea0739ce0420daa4ed25c3b34aec5564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/316cfd65e3815ba3e78a7f837bbfafaca4e49e8f9380317de765e3fd055f2f6ebde535164ee89e12b0264edd93ef8f77d48d161103881867d27531426fb7d8a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd6489770b1229250eaee2cc7423275dfee7ce0210160af1de6b1efdc6030e81c15043618d3d2803f6dde41ddbd24b46f35ee4327d522d8b544ea5257d022a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d9f11704d466e42d7262081af75abedb7c7b03f9d8b6da0facf1d7bcf4957b9c04a2942a3ec1147664967993ef790725443c58cb3a081881fcf59fe8eb228c3"} 18:33:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:33:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:33:15 INFO - Contents: 18:33:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c440f47151593af70be5b554ca4ef06537567515f14a5ecd042e0e926df4cc3e696a50a4674b211235cceb9943776a15ea0739ce0420daa4ed25c3b34aec5564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/316cfd65e3815ba3e78a7f837bbfafaca4e49e8f9380317de765e3fd055f2f6ebde535164ee89e12b0264edd93ef8f77d48d161103881867d27531426fb7d8a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd6489770b1229250eaee2cc7423275dfee7ce0210160af1de6b1efdc6030e81c15043618d3d2803f6dde41ddbd24b46f35ee4327d522d8b544ea5257d022a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d9f11704d466e42d7262081af75abedb7c7b03f9d8b6da0facf1d7bcf4957b9c04a2942a3ec1147664967993ef790725443c58cb3a081881fcf59fe8eb228c3"} 18:33:15 INFO - Running post-run listener: copy_logs_to_upload_dir 18:33:15 INFO - Copying logs to upload dir... 18:33:15 INFO - mkdir: /builds/slave/test/build/upload/logs 18:33:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.635540 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-02-06 18:33:15.595494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 18:33:15.600721) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434 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/c440f47151593af70be5b554ca4ef06537567515f14a5ecd042e0e926df4cc3e696a50a4674b211235cceb9943776a15ea0739ce0420daa4ed25c3b34aec5564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/316cfd65e3815ba3e78a7f837bbfafaca4e49e8f9380317de765e3fd055f2f6ebde535164ee89e12b0264edd93ef8f77d48d161103881867d27531426fb7d8a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd6489770b1229250eaee2cc7423275dfee7ce0210160af1de6b1efdc6030e81c15043618d3d2803f6dde41ddbd24b46f35ee4327d522d8b544ea5257d022a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d9f11704d466e42d7262081af75abedb7c7b03f9d8b6da0facf1d7bcf4957b9c04a2942a3ec1147664967993ef790725443c58cb3a081881fcf59fe8eb228c3"} build_url:https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/dU13_w-NTQGojHqBqkwY4A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c440f47151593af70be5b554ca4ef06537567515f14a5ecd042e0e926df4cc3e696a50a4674b211235cceb9943776a15ea0739ce0420daa4ed25c3b34aec5564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/316cfd65e3815ba3e78a7f837bbfafaca4e49e8f9380317de765e3fd055f2f6ebde535164ee89e12b0264edd93ef8f77d48d161103881867d27531426fb7d8a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd6489770b1229250eaee2cc7423275dfee7ce0210160af1de6b1efdc6030e81c15043618d3d2803f6dde41ddbd24b46f35ee4327d522d8b544ea5257d022a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d9f11704d466e42d7262081af75abedb7c7b03f9d8b6da0facf1d7bcf4957b9c04a2942a3ec1147664967993ef790725443c58cb3a081881fcf59fe8eb228c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 18:33:15.626386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:33:15.626765) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486433544.398408-1876962434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004352 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:33:15.713796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 18:33:15.714651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 18:33:15.715357) ========= ========= Total master_lag: 0.18 =========