builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1471893318.62 results: success (0) buildid: 20160822103614 builduid: b9c782d165b449e8b0df27e4faa74058 revision: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.616839) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.617766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.618246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.636154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.636463) ========= 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=df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 12:15:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-08-22 12:15:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.749821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.750669) ========= 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=df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023863 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.803836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:18.804249) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 --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=df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 12:15:19,063 truncating revision to first 12 chars 2016-08-22 12:15:19,063 Setting DEBUG logging. 2016-08-22 12:15:19,063 attempt 1/10 2016-08-22 12:15:19,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/23e3bb6e8e93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 12:15:19,701 unpacking tar archive at: autoland-23e3bb6e8e93/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:19.803705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:19.804128) ========= script_repo_revision: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:19.804589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:19.804901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 12:15:19.815218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-08-22 12:15:19.815707) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:20 INFO - MultiFileLogger online at 20160822 12:15:20 in /builds/slave/test 12:15:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:15:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:20 INFO - {'append_to_log': False, 12:15:20 INFO - 'base_work_dir': '/builds/slave/test', 12:15:20 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:15:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:20 INFO - 'branch': 'Autoland-Non-PGO', 12:15:20 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:20 INFO - 'config_files': ('talos/linux_config.py',), 12:15:20 INFO - 'default_actions': ('clobber', 12:15:20 INFO - 'read-buildbot-config', 12:15:20 INFO - 'download-and-extract', 12:15:20 INFO - 'populate-webroot', 12:15:20 INFO - 'create-virtualenv', 12:15:20 INFO - 'install', 12:15:20 INFO - 'run-tests'), 12:15:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:20 INFO - 'download_minidump_stackwalk': True, 12:15:20 INFO - 'download_symbols': 'ondemand', 12:15:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:20 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:20 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:20 INFO - 'installer_path': 'installer.exe', 12:15:20 INFO - 'log_level': 'info', 12:15:20 INFO - 'log_name': 'talos', 12:15:20 INFO - 'log_to_console': True, 12:15:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:20 INFO - 'opt_config_files': (), 12:15:20 INFO - 'pip_index': False, 12:15:20 INFO - 'sps_profile': False, 12:15:20 INFO - 'sps_profile_interval': 0, 12:15:20 INFO - 'suite': 'dromaeojs-e10s', 12:15:20 INFO - 'system_bits': '32', 12:15:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:20 INFO - 'title': 'talos-linux64-ix-021', 12:15:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:20 INFO - 'use_talos_json': True, 12:15:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:20 INFO - 'work_dir': 'build'} 12:15:20 INFO - [mozharness: 2016-08-22 19:15:20.170592Z] Running clobber step. 12:15:20 INFO - Running pre-action listener: _resource_record_pre_action 12:15:20 INFO - Running main action method: clobber 12:15:20 INFO - rmtree: /builds/slave/test/build 12:15:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:20 INFO - Running post-action listener: _resource_record_post_action 12:15:20 INFO - [mozharness: 2016-08-22 19:15:20.630036Z] Finished clobber step (success) 12:15:20 INFO - [mozharness: 2016-08-22 19:15:20.630135Z] Running read-buildbot-config step. 12:15:20 INFO - Running pre-action listener: _resource_record_pre_action 12:15:20 INFO - Running main action method: read_buildbot_config 12:15:20 INFO - Using buildbot properties: 12:15:20 INFO - { 12:15:20 INFO - "project": "", 12:15:20 INFO - "product": "firefox", 12:15:20 INFO - "script_repo_revision": "production", 12:15:20 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:15:20 INFO - "repository": "", 12:15:20 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 12:15:20 INFO - "buildid": "20160822103614", 12:15:20 INFO - "pgo_build": "False", 12:15:20 INFO - "basedir": "/builds/slave/test", 12:15:20 INFO - "buildnumber": 328, 12:15:20 INFO - "slavename": "talos-linux64-ix-021", 12:15:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:15:20 INFO - "platform": "ubuntu64_hw", 12:15:20 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 12:15:20 INFO - "branch": "autoland", 12:15:20 INFO - "repo_path": "integration/autoland", 12:15:20 INFO - "revision": "23e3bb6e8e935305529ebeb2bf3c7771c4e51491", 12:15:20 INFO - "stage_platform": "linux64", 12:15:20 INFO - "builduid": "b9c782d165b449e8b0df27e4faa74058", 12:15:20 INFO - "slavebuilddir": "test" 12:15:20 INFO - } 12:15:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:15:20 INFO - Running post-action listener: _resource_record_post_action 12:15:20 INFO - [mozharness: 2016-08-22 19:15:20.632566Z] Finished read-buildbot-config step (success) 12:15:20 INFO - [mozharness: 2016-08-22 19:15:20.632653Z] Running download-and-extract step. 12:15:20 INFO - Running pre-action listener: _resource_record_pre_action 12:15:20 INFO - Running main action method: download_and_extract 12:15:20 INFO - mkdir: /builds/slave/test/build/tests 12:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:20 INFO - trying https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:15:20 INFO - Downloading https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:15:21 INFO - Downloaded 1361 bytes. 12:15:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:15:21 INFO - Using the following test package requirements: 12:15:21 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:15:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:15:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'jsshell-linux-x86_64.zip'], 12:15:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:15:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:15:21 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:15:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:15:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:15:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:21 INFO - trying https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:15:21 INFO - Downloading https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:22 INFO - Downloaded 20331073 bytes. 12:15:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:15:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:26 INFO - trying https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:15:26 INFO - Downloading https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:27 INFO - Downloaded 20331073 bytes. 12:15:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:31 INFO - trying https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:15:31 INFO - Downloading https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:15:32 INFO - Downloaded 14413981 bytes. 12:15:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 12:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:32 INFO - trying https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:15:33 INFO - Downloaded 55772930 bytes. 12:15:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:15:33 INFO - mkdir: /builds/slave/test/properties 12:15:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:33 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:33 INFO - Contents: 12:15:33 INFO - build_url:https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:15:34 INFO - Running post-action listener: _resource_record_post_action 12:15:34 INFO - Running post-action listener: set_extra_try_arguments 12:15:34 INFO - [mozharness: 2016-08-22 19:15:34.633363Z] Finished download-and-extract step (success) 12:15:34 INFO - [mozharness: 2016-08-22 19:15:34.633627Z] Running populate-webroot step. 12:15:34 INFO - Running pre-action listener: _resource_record_pre_action 12:15:34 INFO - Running main action method: populate_webroot 12:15:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:34 INFO - '--tppagecycles', 12:15:34 INFO - '7'], 12:15:34 INFO - 'tests': ['tsvgm']}}, 12:15:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:15:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:15:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['damp', 'tps']}, 12:15:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'tests': ['damp', 'tps']}, 12:15:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['dromaeo_dom']}, 12:15:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['basic_compositor_video']}, 12:15:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:15:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['a11yr', 12:15:34 INFO - 'ts_paint', 12:15:34 INFO - 'tpaint', 12:15:34 INFO - 'sessionrestore', 12:15:34 INFO - 'sessionrestore_no_auto_restore', 12:15:34 INFO - 'tabpaint']}, 12:15:34 INFO - 'other-e10s': {'tests': ['a11yr', 12:15:34 INFO - 'ts_paint', 12:15:34 INFO - 'tpaint', 12:15:34 INFO - 'sessionrestore', 12:15:34 INFO - 'sessionrestore_no_auto_restore', 12:15:34 INFO - 'tabpaint']}, 12:15:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:15:34 INFO - 'ts_paint', 12:15:34 INFO - 'tpaint', 12:15:34 INFO - 'sessionrestore', 12:15:34 INFO - 'sessionrestore_no_auto_restore', 12:15:34 INFO - 'tabpaint']}, 12:15:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:15:34 INFO - 'ts_paint', 12:15:34 INFO - 'tpaint', 12:15:34 INFO - 'sessionrestore', 12:15:34 INFO - 'sessionrestore_no_auto_restore', 12:15:34 INFO - 'tabpaint']}, 12:15:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['a11yr', 12:15:34 INFO - 'ts_paint', 12:15:34 INFO - 'tpaint', 12:15:34 INFO - 'sessionrestore', 12:15:34 INFO - 'sessionrestore_no_auto_restore', 12:15:34 INFO - 'tabpaint']}, 12:15:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['a11yr', 12:15:34 INFO - 'ts_paint', 12:15:34 INFO - 'tpaint', 12:15:34 INFO - 'sessionrestore', 12:15:34 INFO - 'sessionrestore_no_auto_restore', 12:15:34 INFO - 'tabpaint']}, 12:15:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['tsvgx', 12:15:34 INFO - 'tsvgr_opacity', 12:15:34 INFO - 'tart', 12:15:34 INFO - 'tscrollx', 12:15:34 INFO - 'cart']}, 12:15:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:15:34 INFO - 'tsvgr_opacity', 12:15:34 INFO - 'tart', 12:15:34 INFO - 'tscrollx', 12:15:34 INFO - 'cart']}, 12:15:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'talos_options': ['--disable-e10s'], 12:15:34 INFO - 'tests': ['tp5o']}, 12:15:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'tests': ['tp5o']}, 12:15:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'talos_options': ['--disable-e10s', 12:15:34 INFO - '--xperf_path', 12:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:34 INFO - 'tests': ['tp5n']}, 12:15:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:34 INFO - 'talos_options': ['--xperf_path', 12:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:34 INFO - 'tests': ['tp5n']}}, 12:15:34 INFO - 'talos.zip': {'path': '', 12:15:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:34 INFO - Running post-action listener: _resource_record_post_action 12:15:34 INFO - [mozharness: 2016-08-22 19:15:34.651881Z] Finished populate-webroot step (success) 12:15:34 INFO - [mozharness: 2016-08-22 19:15:34.651968Z] Running create-virtualenv step. 12:15:34 INFO - Running pre-action listener: _resource_record_pre_action 12:15:34 INFO - Running main action method: create_virtualenv 12:15:34 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:15:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:34 INFO - Using real prefix '/usr' 12:15:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:35 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:37 INFO - Installing pip.................done. 12:15:37 INFO - Return code: 0 12:15:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:15:37 INFO - Using env: {'DISPLAY': ':0', 12:15:37 INFO - 'HOME': '/home/cltbld', 12:15:37 INFO - 'LANG': 'en_US.UTF-8', 12:15:37 INFO - 'LANGUAGE': 'en_US:en', 12:15:37 INFO - 'LOGNAME': 'cltbld', 12:15:37 INFO - 'MAIL': '/var/mail/cltbld', 12:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:37 INFO - 'MOZ_NO_REMOTE': '1', 12:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:37 INFO - 'NO_EM_RESTART': '1', 12:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:37 INFO - 'PWD': '/builds/slave/test', 12:15:37 INFO - 'SHELL': '/bin/bash', 12:15:37 INFO - 'SHLVL': '1', 12:15:37 INFO - 'TERM': 'linux', 12:15:37 INFO - 'TMOUT': '86400', 12:15:37 INFO - 'USER': 'cltbld', 12:15:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:37 INFO - '_': '/tools/buildbot/bin/python'} 12:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:15:37 INFO - Cleaning up... 12:15:37 INFO - Return code: 0 12:15:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:15:37 INFO - Using env: {'DISPLAY': ':0', 12:15:37 INFO - 'HOME': '/home/cltbld', 12:15:37 INFO - 'LANG': 'en_US.UTF-8', 12:15:37 INFO - 'LANGUAGE': 'en_US:en', 12:15:37 INFO - 'LOGNAME': 'cltbld', 12:15:37 INFO - 'MAIL': '/var/mail/cltbld', 12:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:37 INFO - 'MOZ_NO_REMOTE': '1', 12:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:37 INFO - 'NO_EM_RESTART': '1', 12:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:37 INFO - 'PWD': '/builds/slave/test', 12:15:37 INFO - 'SHELL': '/bin/bash', 12:15:37 INFO - 'SHLVL': '1', 12:15:37 INFO - 'TERM': 'linux', 12:15:37 INFO - 'TMOUT': '86400', 12:15:37 INFO - 'USER': 'cltbld', 12:15:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:37 INFO - '_': '/tools/buildbot/bin/python'} 12:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:37 INFO - Downloading/unpacking psutil>=3.1.1 12:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:39 INFO - Installing collected packages: psutil 12:15:39 INFO - Running setup.py install for psutil 12:15:39 INFO - building 'psutil._psutil_linux' extension 12:15:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:15:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:15:40 INFO - building 'psutil._psutil_posix' extension 12:15:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:15:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:15:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:40 INFO - Successfully installed psutil 12:15:40 INFO - Cleaning up... 12:15:40 INFO - Return code: 0 12:15:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:40 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:15:40 INFO - Using env: {'DISPLAY': ':0', 12:15:40 INFO - 'HOME': '/home/cltbld', 12:15:40 INFO - 'LANG': 'en_US.UTF-8', 12:15:40 INFO - 'LANGUAGE': 'en_US:en', 12:15:40 INFO - 'LOGNAME': 'cltbld', 12:15:40 INFO - 'MAIL': '/var/mail/cltbld', 12:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:40 INFO - 'MOZ_NO_REMOTE': '1', 12:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:40 INFO - 'NO_EM_RESTART': '1', 12:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:40 INFO - 'PWD': '/builds/slave/test', 12:15:40 INFO - 'SHELL': '/bin/bash', 12:15:40 INFO - 'SHLVL': '1', 12:15:40 INFO - 'TERM': 'linux', 12:15:40 INFO - 'TMOUT': '86400', 12:15:40 INFO - 'USER': 'cltbld', 12:15:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:40 INFO - '_': '/tools/buildbot/bin/python'} 12:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:42 INFO - Installing collected packages: mozsystemmonitor 12:15:42 INFO - Running setup.py install for mozsystemmonitor 12:15:42 INFO - Successfully installed mozsystemmonitor 12:15:42 INFO - Cleaning up... 12:15:42 INFO - Return code: 0 12:15:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:15:42 INFO - Using env: {'DISPLAY': ':0', 12:15:42 INFO - 'HOME': '/home/cltbld', 12:15:42 INFO - 'LANG': 'en_US.UTF-8', 12:15:42 INFO - 'LANGUAGE': 'en_US:en', 12:15:42 INFO - 'LOGNAME': 'cltbld', 12:15:42 INFO - 'MAIL': '/var/mail/cltbld', 12:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:42 INFO - 'MOZ_NO_REMOTE': '1', 12:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:42 INFO - 'NO_EM_RESTART': '1', 12:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:42 INFO - 'PWD': '/builds/slave/test', 12:15:42 INFO - 'SHELL': '/bin/bash', 12:15:42 INFO - 'SHLVL': '1', 12:15:42 INFO - 'TERM': 'linux', 12:15:42 INFO - 'TMOUT': '86400', 12:15:42 INFO - 'USER': 'cltbld', 12:15:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:42 INFO - '_': '/tools/buildbot/bin/python'} 12:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:42 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:44 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:45 INFO - warning: no files found matching '*.txt' 12:15:45 INFO - no previously-included directories found matching 'build' 12:15:45 INFO - no previously-included directories found matching 'dist' 12:15:45 INFO - no previously-included directories found matching '.git*' 12:15:45 INFO - Installing collected packages: jsonschema, functools32 12:15:45 INFO - Running setup.py install for functools32 12:15:45 INFO - warning: no files found matching '*.txt' 12:15:45 INFO - no previously-included directories found matching 'build' 12:15:45 INFO - no previously-included directories found matching 'dist' 12:15:45 INFO - no previously-included directories found matching '.git*' 12:15:45 INFO - Successfully installed jsonschema functools32 12:15:45 INFO - Cleaning up... 12:15:45 INFO - Return code: 0 12:15:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:15:45 INFO - Using env: {'DISPLAY': ':0', 12:15:45 INFO - 'HOME': '/home/cltbld', 12:15:45 INFO - 'LANG': 'en_US.UTF-8', 12:15:45 INFO - 'LANGUAGE': 'en_US:en', 12:15:45 INFO - 'LOGNAME': 'cltbld', 12:15:45 INFO - 'MAIL': '/var/mail/cltbld', 12:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:45 INFO - 'MOZ_NO_REMOTE': '1', 12:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:45 INFO - 'NO_EM_RESTART': '1', 12:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:45 INFO - 'PWD': '/builds/slave/test', 12:15:45 INFO - 'SHELL': '/bin/bash', 12:15:45 INFO - 'SHLVL': '1', 12:15:45 INFO - 'TERM': 'linux', 12:15:45 INFO - 'TMOUT': '86400', 12:15:45 INFO - 'USER': 'cltbld', 12:15:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:45 INFO - '_': '/tools/buildbot/bin/python'} 12:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:45 INFO - Cleaning up... 12:15:45 INFO - Return code: 0 12:15:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:15:45 INFO - Using env: {'DISPLAY': ':0', 12:15:45 INFO - 'HOME': '/home/cltbld', 12:15:45 INFO - 'LANG': 'en_US.UTF-8', 12:15:45 INFO - 'LANGUAGE': 'en_US:en', 12:15:45 INFO - 'LOGNAME': 'cltbld', 12:15:45 INFO - 'MAIL': '/var/mail/cltbld', 12:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:45 INFO - 'MOZ_NO_REMOTE': '1', 12:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:45 INFO - 'NO_EM_RESTART': '1', 12:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:45 INFO - 'PWD': '/builds/slave/test', 12:15:45 INFO - 'SHELL': '/bin/bash', 12:15:45 INFO - 'SHLVL': '1', 12:15:45 INFO - 'TERM': 'linux', 12:15:45 INFO - 'TMOUT': '86400', 12:15:45 INFO - 'USER': 'cltbld', 12:15:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:45 INFO - '_': '/tools/buildbot/bin/python'} 12:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:45 INFO - Downloading/unpacking blobuploader==1.2.4 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:47 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:48 INFO - Downloading docopt-0.6.1.tar.gz 12:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:48 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:48 INFO - Running setup.py install for blobuploader 12:15:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:48 INFO - Running setup.py install for requests 12:15:48 INFO - Running setup.py install for docopt 12:15:48 INFO - Successfully installed blobuploader requests docopt 12:15:48 INFO - Cleaning up... 12:15:48 INFO - Return code: 0 12:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:48 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:48 INFO - Using env: {'DISPLAY': ':0', 12:15:48 INFO - 'HOME': '/home/cltbld', 12:15:48 INFO - 'LANG': 'en_US.UTF-8', 12:15:48 INFO - 'LANGUAGE': 'en_US:en', 12:15:48 INFO - 'LOGNAME': 'cltbld', 12:15:48 INFO - 'MAIL': '/var/mail/cltbld', 12:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:48 INFO - 'MOZ_NO_REMOTE': '1', 12:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:48 INFO - 'NO_EM_RESTART': '1', 12:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:48 INFO - 'PWD': '/builds/slave/test', 12:15:48 INFO - 'SHELL': '/bin/bash', 12:15:48 INFO - 'SHLVL': '1', 12:15:48 INFO - 'TERM': 'linux', 12:15:48 INFO - 'TMOUT': '86400', 12:15:48 INFO - 'USER': 'cltbld', 12:15:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:48 INFO - '_': '/tools/buildbot/bin/python'} 12:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:49 INFO - Running setup.py (path:/tmp/pip-bWOWCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:49 INFO - Running setup.py (path:/tmp/pip-htpWaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:49 INFO - Running setup.py (path:/tmp/pip-JE29rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:49 INFO - Running setup.py (path:/tmp/pip-554s1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:49 INFO - Running setup.py (path:/tmp/pip-xZcWzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:49 INFO - Running setup.py (path:/tmp/pip-qsaAIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:49 INFO - Running setup.py (path:/tmp/pip-fkkrPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:49 INFO - Running setup.py (path:/tmp/pip-tinD6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:49 INFO - Running setup.py (path:/tmp/pip-cMP9IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:49 INFO - Running setup.py (path:/tmp/pip-Y48OMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:49 INFO - Running setup.py (path:/tmp/pip-s5tS23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:49 INFO - Running setup.py (path:/tmp/pip-13gY_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:50 INFO - Running setup.py (path:/tmp/pip-2huovz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:50 INFO - Running setup.py (path:/tmp/pip-ljNsbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:50 INFO - Running setup.py (path:/tmp/pip-U6yBvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:50 INFO - Running setup.py (path:/tmp/pip-wsMbpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:50 INFO - Running setup.py (path:/tmp/pip-bIP_Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:50 INFO - Running setup.py install for manifestparser 12:15:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Running setup.py install for mozcrash 12:15:50 INFO - Running setup.py install for mozdebug 12:15:50 INFO - Running setup.py install for mozdevice 12:15:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:50 INFO - Running setup.py install for mozfile 12:15:50 INFO - Running setup.py install for mozhttpd 12:15:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Running setup.py install for mozinfo 12:15:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Running setup.py install for mozInstall 12:15:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Running setup.py install for mozleak 12:15:51 INFO - Running setup.py install for mozlog 12:15:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Running setup.py install for moznetwork 12:15:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Running setup.py install for mozprocess 12:15:51 INFO - Running setup.py install for mozprofile 12:15:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Running setup.py install for mozrunner 12:15:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:51 INFO - Running setup.py install for mozscreenshot 12:15:51 INFO - Running setup.py install for moztest 12:15:52 INFO - Running setup.py install for mozversion 12:15:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:52 INFO - Cleaning up... 12:15:52 INFO - Return code: 0 12:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:52 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:52 INFO - Using env: {'DISPLAY': ':0', 12:15:52 INFO - 'HOME': '/home/cltbld', 12:15:52 INFO - 'LANG': 'en_US.UTF-8', 12:15:52 INFO - 'LANGUAGE': 'en_US:en', 12:15:52 INFO - 'LOGNAME': 'cltbld', 12:15:52 INFO - 'MAIL': '/var/mail/cltbld', 12:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:52 INFO - 'MOZ_NO_REMOTE': '1', 12:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:52 INFO - 'NO_EM_RESTART': '1', 12:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:52 INFO - 'PWD': '/builds/slave/test', 12:15:52 INFO - 'SHELL': '/bin/bash', 12:15:52 INFO - 'SHLVL': '1', 12:15:52 INFO - 'TERM': 'linux', 12:15:52 INFO - 'TMOUT': '86400', 12:15:52 INFO - 'USER': 'cltbld', 12:15:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:52 INFO - '_': '/tools/buildbot/bin/python'} 12:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:52 INFO - Running setup.py (path:/tmp/pip-Z1J2Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:52 INFO - Running setup.py (path:/tmp/pip-rG3IGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:52 INFO - Running setup.py (path:/tmp/pip-lGudT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:52 INFO - Running setup.py (path:/tmp/pip-F4KevN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:52 INFO - Running setup.py (path:/tmp/pip-pR2LL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:52 INFO - Running setup.py (path:/tmp/pip-xzqL7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:52 INFO - Running setup.py (path:/tmp/pip-J3O62F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:52 INFO - Running setup.py (path:/tmp/pip-1XzF8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:53 INFO - Running setup.py (path:/tmp/pip-Ikx29C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:53 INFO - Running setup.py (path:/tmp/pip-vDUScl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:53 INFO - Running setup.py (path:/tmp/pip-mZul7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:53 INFO - Running setup.py (path:/tmp/pip-_uj9NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:53 INFO - Running setup.py (path:/tmp/pip-CWjowx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:53 INFO - Running setup.py (path:/tmp/pip-duHNFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:53 INFO - Running setup.py (path:/tmp/pip-d1A8lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:53 INFO - Running setup.py (path:/tmp/pip-u8fK89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:53 INFO - Running setup.py (path:/tmp/pip-OVsKM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:55 INFO - Downloading blessings-1.6.tar.gz 12:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:55 INFO - Installing collected packages: blessings 12:15:55 INFO - Running setup.py install for blessings 12:15:55 INFO - Successfully installed blessings 12:15:55 INFO - Cleaning up... 12:15:55 INFO - Return code: 0 12:15:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:56 INFO - Reading from file tmpfile_stdout 12:15:56 INFO - Current package versions: 12:15:56 INFO - argparse == 1.2.1 12:15:56 INFO - blessings == 1.6 12:15:56 INFO - blobuploader == 1.2.4 12:15:56 INFO - docopt == 0.6.1 12:15:56 INFO - functools32 == 3.2.3-2 12:15:56 INFO - jsonschema == 2.5.1 12:15:56 INFO - manifestparser == 1.1 12:15:56 INFO - mozInstall == 1.12 12:15:56 INFO - mozcrash == 0.17 12:15:56 INFO - mozdebug == 0.1 12:15:56 INFO - mozdevice == 0.48 12:15:56 INFO - mozfile == 1.2 12:15:56 INFO - mozhttpd == 0.7 12:15:56 INFO - mozinfo == 0.9 12:15:56 INFO - mozleak == 0.1 12:15:56 INFO - mozlog == 3.3 12:15:56 INFO - moznetwork == 0.27 12:15:56 INFO - mozprocess == 0.23 12:15:56 INFO - mozprofile == 0.28 12:15:56 INFO - mozrunner == 6.12 12:15:56 INFO - mozscreenshot == 0.1 12:15:56 INFO - mozsystemmonitor == 0.3 12:15:56 INFO - moztest == 0.7 12:15:56 INFO - mozversion == 1.4 12:15:56 INFO - psutil == 3.1.1 12:15:56 INFO - requests == 1.2.3 12:15:56 INFO - wsgiref == 0.1.2 12:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:56 INFO - Using env: {'DISPLAY': ':0', 12:15:56 INFO - 'HOME': '/home/cltbld', 12:15:56 INFO - 'LANG': 'en_US.UTF-8', 12:15:56 INFO - 'LANGUAGE': 'en_US:en', 12:15:56 INFO - 'LOGNAME': 'cltbld', 12:15:56 INFO - 'MAIL': '/var/mail/cltbld', 12:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:56 INFO - 'MOZ_NO_REMOTE': '1', 12:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:56 INFO - 'NO_EM_RESTART': '1', 12:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:56 INFO - 'PWD': '/builds/slave/test', 12:15:56 INFO - 'SHELL': '/bin/bash', 12:15:56 INFO - 'SHLVL': '1', 12:15:56 INFO - 'TERM': 'linux', 12:15:56 INFO - 'TMOUT': '86400', 12:15:56 INFO - 'USER': 'cltbld', 12:15:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:56 INFO - '_': '/tools/buildbot/bin/python'} 12:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:15:56 INFO - Cleaning up... 12:15:56 INFO - Return code: 0 12:15:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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 0x7fa167568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, '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': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:15:56 INFO - Using env: {'DISPLAY': ':0', 12:15:56 INFO - 'HOME': '/home/cltbld', 12:15:56 INFO - 'LANG': 'en_US.UTF-8', 12:15:56 INFO - 'LANGUAGE': 'en_US:en', 12:15:56 INFO - 'LOGNAME': 'cltbld', 12:15:56 INFO - 'MAIL': '/var/mail/cltbld', 12:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:56 INFO - 'MOZ_NO_REMOTE': '1', 12:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:56 INFO - 'NO_EM_RESTART': '1', 12:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:56 INFO - 'PWD': '/builds/slave/test', 12:15:56 INFO - 'SHELL': '/bin/bash', 12:15:56 INFO - 'SHLVL': '1', 12:15:56 INFO - 'TERM': 'linux', 12:15:56 INFO - 'TMOUT': '86400', 12:15:56 INFO - 'USER': 'cltbld', 12:15:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:56 INFO - '_': '/tools/buildbot/bin/python'} 12:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:15:56 INFO - Cleaning up... 12:15:56 INFO - Return code: 0 12:15:56 INFO - Running post-action listener: _resource_record_post_action 12:15:56 INFO - Running post-action listener: _start_resource_monitoring 12:15:56 INFO - Starting resource monitoring. 12:15:56 INFO - [mozharness: 2016-08-22 19:15:56.498539Z] Finished create-virtualenv step (success) 12:15:56 INFO - [mozharness: 2016-08-22 19:15:56.498993Z] Running install step. 12:15:56 INFO - Running pre-action listener: _resource_record_pre_action 12:15:56 INFO - Running main action method: install 12:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:56 INFO - Reading from file tmpfile_stdout 12:15:56 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:56 INFO - Reading from file tmpfile_stdout 12:15:56 INFO - Output received: 12:15:56 INFO - Usage: mozinstall [options] installer 12:15:56 INFO - Options: 12:15:56 INFO - -h, --help show this help message and exit 12:15:56 INFO - -d DEST, --destination=DEST 12:15:56 INFO - Directory to install application into. [default: 12:15:56 INFO - "/builds/slave/test"] 12:15:56 INFO - --app=APP Application being installed. [default: firefox] 12:15:56 INFO - mkdir: /builds/slave/test/build/application 12:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:16:12 INFO - Reading from file tmpfile_stdout 12:16:12 INFO - Output received: 12:16:12 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:12 INFO - Running post-action listener: _resource_record_post_action 12:16:12 INFO - [mozharness: 2016-08-22 19:16:12.918144Z] Finished install step (success) 12:16:12 INFO - [mozharness: 2016-08-22 19:16:12.918391Z] Running run-tests step. 12:16:12 INFO - Running pre-action listener: _resource_record_pre_action 12:16:12 INFO - Running main action method: run_tests 12:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:12 INFO - Python 2.7.3 12:16:12 INFO - Return code: 0 12:16:12 INFO - grabbing minidump binary from tooltool 12:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:12 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 0x2688090>, '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 0x268b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:16:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:16:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:16:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:12 INFO - Return code: 0 12:16:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:16:12 INFO - Using env: {'DISPLAY': ':0', 12:16:12 INFO - 'HOME': '/home/cltbld', 12:16:12 INFO - 'LANG': 'en_US.UTF-8', 12:16:12 INFO - 'LANGUAGE': 'en_US:en', 12:16:12 INFO - 'LOGNAME': 'cltbld', 12:16:13 INFO - 'MAIL': '/var/mail/cltbld', 12:16:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:13 INFO - 'MOZ_NO_REMOTE': '1', 12:16:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:13 INFO - 'NO_EM_RESTART': '1', 12:16:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:13 INFO - 'PWD': '/builds/slave/test', 12:16:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:13 INFO - 'SHELL': '/bin/bash', 12:16:13 INFO - 'SHLVL': '1', 12:16:13 INFO - 'TERM': 'linux', 12:16:13 INFO - 'TMOUT': '86400', 12:16:13 INFO - 'USER': 'cltbld', 12:16:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040', 12:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:13 INFO - '_': '/tools/buildbot/bin/python'} 12:16:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:16:13 INFO - mozversion application_buildid: 20160822103614 12:16:13 INFO - mozversion application_changeset: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 12:16:13 INFO - mozversion application_display_name: Nightly 12:16:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:13 INFO - mozversion application_name: Firefox 12:16:13 INFO - mozversion application_remotingname: firefox 12:16:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:16:13 INFO - mozversion application_vendor: Mozilla 12:16:13 INFO - mozversion application_version: 51.0a1 12:16:13 INFO - mozversion platform_buildid: 20160822103614 12:16:13 INFO - mozversion platform_changeset: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 12:16:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:16:13 INFO - mozversion platform_version: 51.0a1 12:16:13 INFO - using testdate: 1471893373 12:16:13 INFO - actual date: 1471893373 12:16:13 INFO - starting webserver on 'localhost:46737' 12:16:13 INFO - SUITE-START | Running 2 tests 12:16:13 INFO - TEST-START | dromaeo_css 12:16:13 INFO - operating with platform_type : linux_ 12:16:13 INFO - Initialising browser for dromaeo_css test... 12:16:13 INFO - TEST-INFO | started process 23213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDe6_X/profile http://localhost:46737/getInfo.html) 12:16:19 INFO - PROCESS | 23213 | __metrics Screen width/height:1600/1200 12:16:19 INFO - PROCESS | 23213 | colorDepth:24 12:16:19 INFO - PROCESS | 23213 | Browser inner width/height: 1024/697 12:16:19 INFO - PROCESS | 23213 | __metrics 12:16:20 ERROR - PROCESS | 23213 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 12:16:21 INFO - TEST-INFO | 23213: exit 0 12:16:21 INFO - Browser initialized. 12:16:21 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:21 INFO - TEST-INFO | started process 23334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDe6_X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:33 INFO - PROCESS | 23334 | RSS: Main: 188043264 12:16:33 INFO - PROCESS | 23334 | 12:17:23 INFO - PROCESS | 23334 | 1471893443179 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:19:35 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:46737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46737/tests/dromaeo/cssquery-ext.html) 12:19:36 INFO - PROCESS | 23334 | RSS: Main: 197767168 12:19:36 INFO - PROCESS | 23334 | 12:22:39 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:46737/tests/dromaeo/cssquery-ext.html (next: http://localhost:46737/tests/dromaeo/cssquery-jquery.html) 12:22:39 INFO - PROCESS | 23334 | RSS: Main: 199229440 12:22:39 INFO - PROCESS | 23334 | 12:25:41 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:46737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46737/tests/dromaeo/cssquery-mootools.html) 12:25:42 INFO - PROCESS | 23334 | RSS: Main: 199692288 12:25:42 INFO - PROCESS | 23334 | 12:28:44 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:46737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46737/tests/dromaeo/cssquery-prototype.html) 12:28:45 INFO - PROCESS | 23334 | RSS: Main: 197136384 12:28:45 INFO - PROCESS | 23334 | 12:31:48 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:46737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46737/tests/dromaeo/cssquery-yui.html) 12:31:48 INFO - PROCESS | 23334 | RSS: Main: 198787072 12:31:48 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:46737/tests/dromaeo/cssquery-yui.html (next: http://localhost:46737/tests/dromaeo/cssquery-dojo.html) 12:34:51 INFO - PROCESS | 23334 | RSS: Main: 199708672 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | __start_tp_report 12:34:51 INFO - PROCESS | 23334 | _x_x_mozilla_page_load 12:34:51 INFO - PROCESS | 23334 | _x_x_mozilla_page_load_details 12:34:51 INFO - PROCESS | 23334 | |i|pagename|runs| 12:34:51 INFO - PROCESS | 23334 | |0;dojo.html;2606.2441891851363;2623.9868800655995;2631.657884475018;2640.1815437214477;2642.4715056988607;4632.976835115828;4723.598494127999;4750.619950403964;4798.808047678093;4808.543188397105;4694.6244300455965;4738.834140805073;4740;4740.9762951185285;4782.7847746851385;4254.638355739766;4379.781010949448;4417.558244175589;4527.750973696446;4528.026474308023;4459.464864216298;4463.285874260119;4515.074409745994;4525.140223357552;4528.411306530146;4205.095904380542;4328.63206627437;4377.693561450668;4391.055922976575;4458.398116254297;4437.4009508716235;4442.689011769177;4447.510773814878;4455.598996090335;4466.977665111686;4372.912541749179;4399.978000110011;4429.712068715556;4430.977845110754;4442.42248507692;4651.953480465186;4783.784729687138;4786.64100192487;4836.419629644465;4869.586085182764;5196.58427325813;5213.608979326527;5218.399884013349;5221.686698798084;5242.056429842627;4981.078500477423;5144.819931302386;5146.073706732786;5151.227315902607;5152.9484705152845;4661.557152070548;4739.95260047402;4757.500462451462;4761.714297142183;4763.928541071887;5210.557102646318;5211.895762084737;5214.139666954986;5214.921776173361;5215.687058776485;4858.17411040124;5000.64995450315;5001.399832020181;5006.3992320921725;5013.997200559903;4912.526242127347;4978.726170060681;5029.421616514074;5048.823291184791;5099.821506247264;5054.772535235923;5056.494350564914;5069.949300506948;5113.693178409308;5123.052235336475;4907.362042934467;5089.033083714083;5095.0828850806465;5107.719075450886;5108;4130.050088479667;4182.477190351206;4209.473815773028;4219.346001369792;4255.0426154115075;3710.350688629479;3712.387456069718;3718.3864662330952;3719.888403347904;3740.214554943438;4348.2825333819565;4399.824007039682;4411.647068234533;4440.178566965122;4447.533009034005;5005.699658020458;5067.265246539231;5090.643654944119;5134.897302053938;5136.4606716295;4438.267685831802;4458.777061146994;4468.731876087445;4472.373867658531;4483.820647174077;4504.954950450519;4583.9083218335445;4590.104929538707;4593.081383723269;4597;4935.753212339297;4947.35684361038;4956.752162391938;4960.8759781005765;4970.055689418999;5204.713740744295;5218.8956220876125;5220.738963051908;5224.477552244745;5228.451012643618;4783.832565860317;4885.169521181337;4891.63312751538;4963.478834722302;4963.528464795983;5086.262491938722;5089.338386009795;5094.184930411265;5115.130427827204;5115.897682046412;5196.012757576049;5201.193814958688;5203.037438073969;5204.791808327776;5206.323177986837;4822.614190864652;4846.61227101824;4947.381577302837;4987.301777751045;5044.1172794761505;4933.901321973469;4983.426905905867;4996.475370086088;5003.474635163401;5009.474005229398;4956.603471722326;4967.975160124176;4979.975100124476;4981.850544483671;4982.252662100714;4886.998165376161;4942.678725882806;5008.4240312364545;5074.213496907985;5086.720230387365;4951.059298733229;4956.504349565014;4961.578265847444;4970.130227210296;4972.627052971114 12:34:51 INFO - PROCESS | 23334 | |1;ext.html;536.4581772409867;540.8107162493128;558.5643198305321;559.4461483131698;560.43676105514;34215.4867676985;38093.99999999996;38095.42856857149;38102;38182.61817381826;37902.241955160884;38376;38450;38458.8077059615;38517.22965540695;7529.397648188132;7636.312731854132;7649.885251721229;7652.19651936547;7667.769966901002;7663.693452261903;7726.690932362699;7749.341305988998;7766.495177813424;7783.766487005399;7693.346065584432;7739.961300193491;7754.651040703154;7759.45683802134;7764.37884969204;7728.26581474759;7758.991331126946;7760.534367937942;7761.068671759369;7778.105517865405;7563.697452101965;7575.0909890813455;7626.580538070404;7646;7649.579273139975;36489.81755091234;36662.450063249074;36698.4495232569;36837.631623683956;36944.44583331252;2749.3422032467815;2840.247334456371;2916.47503449379;3070.7850450468477;3260.168656992452;27893.302667433476;27906.441871162464;28230.717692823015;28342.858285708644;31248.687513124805;3461.13471632092;3520.68313851752;3570.125319296789;3583.7491375603718;3613.1689711366535;266612;268720;268824;269151;269164;30052;52162.47837521576;52393;52488.47511524912;52567.73716131395;30972;32568;32612.347753044807;32721.509177362357;32750;12216.816747748791;12319.199252048587;12336.568220112253;12355.567555135527;12408.56570020045;10033.147182489423;10093.798124037477;10101.494925253855;10138.391696498235;10149.34029288094;7695.846083078307;7707.961460192663;7761.4178936578855;7804.180561041123;7814.726484573012;3063.9234019149253;3064.0960916529675;3089.6601373848857;3093.2421556718746;3107.533869919485;815.9224873636995;892.8258989496986;944.6740874398322;976.9853452198223;987.8666380038603;27927.441451170864;28350;28669.426611467654;28834.27914302159;29131.35858017748;841.3143288220081;928.1182876267438;958.3722661656626;1009.7172791618359;1070.710908054821;13993.72012559743;14849.331780069922;14957.177355245565;15186.468473603592;15217.31522081509;380441;383875;384455;384778;385839;47033;47369.52630473651;47523.28715069277;47615.76192119087;47728.28407573889;1140.6235942139074;1164.3596022187762;1181.9054475641929;1183.8461000069935;1188.0554958807595;26805.803359471785;27658.5851212236;27904.720952790212;28203.2949176264;28421.57367639446;41874;42000.15999679928;42085.36871946862;42207;42216;328454;328572;329043;331306;331807;24832.50334993326;25093.623595646444;25093.74906250914;25223.36941576475;25257.368565785266;40026;41159.588404116774;41234.1753164929;41617.37573936333;42581.57418425776;35322;35984.460233096004;36279.27441451209;36720;36733.816330919246;35691;36420.45369319515;37239;37804;37819.62180378271;34727.65272347244;35300;35402.93791186268;35534.46698299476;36000.8199959009;30337.696623033487;32886.342273153925;33240.66759332376;33335;33373;25583.360415989748;25602.87198563995;25744.356391089623;26152.42332591827;26345 12:34:51 INFO - PROCESS | 23334 | |2;jquery.html;352.6033212635785;360.81959020489757;367.63053131602743;374.9837939184809;378.21520345283545;15687.52937411878;16247.187640617965;17099.40152094677;17174.656506869855;17223.655526889455;12878.871211287884;14828.703425931475;14954.32705528251;15859.127747973856;16316.51050468485;4615.999999999992;4921.507849215086;4923.9753801230945;4950.133726597849;5001.624878134136;4831.589314908237;4952.232403977389;4956.950430495685;4962;5007.7496125193775;4700.106979673868;4803.927941080887;4866.853994380156;4869.4887036861155;4921.089598424285;4893.119238537062;4915.2872833439305;4953.0589188054155;4953.108440480712;4958.727270000149;4176.331786914109;4316.69783115179;4334.176506463793;4352.956470435319;4391.451068616423;19734;20117.195312187494;20226.39320820378;20227.89886050575;20352.491187720276;1891.933782317626;1923.7114432835047;2008.4275981345247;2196.3081629286726;2240.7759224077463;12802;12989.935050324688;13100.279484628341;13321.134126281857;13571.321433928362;1682.3186609423203;1757.8242175782448;1779.88430752002;1781.910904454785;1789.8836575622543;41752.58247417517;42838.14323713508;45766.54233457656;59643.70178149082;59941.700291498266;9136.81726365469;9175;9247.583858726373;9389.76525586852;9496.43021418717;12788.657190994998;12831.743365132832;12842.486300547873;12856.935715321551;12891.806622900664;6758.459323254128;6818.897716534256;6916;6936.653167341613;6954.65226738661;6366.36336366369;6444.226692796894;6455.386738259858;6605.207375114921;6636.966815165893;5696.316442026983;5822.854428639318;5932.673702946379;5996.991008012365;6145.723442445101;1765.1174412793603;1799.668245498348;1803.3327668762379;1803.9729404058949;1812.0667856054142;849.4648371525899;860.2816648098908;950.3632566180676;958.8465845464832;1010.9747256318503;16548;17629.55926101832;17630.501407380518;17911.373101941368;17997.550061248574;838.714836955438;846.6740304982626;873.5457562067817;895.1540793949786;940.5908429833045;9397.436153830791;10063.295569310225;10089.899101009043;10165.847512287322;10172.338797978107;376878;379967;384564;385700;401593;67314.32685673179;68316;69424.6528767363;70648.64675676588;71360.64319678368;909.5134103254859;922.1792604581927;943.2689665509148;949.8907625623003;955.4840386191379;15024.774628380364;15164.24178791034;15327.38690452414;15582.766258506359;15815.762763558785;34870.47694284537;35380.823095884356;35459.290814183056;35809.82095089508;35921.46117808287;50428.49571504238;51248.48751512586;53077;54898.451015489336;55085.173722393396;7176.672315621627;7224.2053374129855;7367.189609143097;7526.661300241392;7647.655855486405;8585.914140858511;10819.513121909691;10920.563177472812;10930.45347732626;11170.106391488498;9742.75643108928;10051.34666246721;10106.444145572064;10594;10863.728406789893;9082.591283392396;9330.113639204264;9384.108509691569;9389.859152112587;9424.481653508848;9890.505474726378;10111.597081535734;10186.286959912735;10332.173426126043;10529.315594486334;7303.963480182565;7329.193788683134;7361.705531778669;7401.111866576045;7487.138979017483;10093.394396336244;10468.267221294436;10604.787904241717;10756.784864302514;10880.45597720095 12:34:51 INFO - PROCESS | 23334 | |3;mootools.html;1338.0566700476163;1389.798479220513;1438.4965262158246;1622.7971503562055;1647.2839247810102;6718.46252299816;7504.3996480281585;7588.962055189723;8064.4758090724135;8098.554579498125;7611.923880761191;7876.330511906481;7890.40821938354;7891.329237014861;7943.960280198591;2118.163325486436;2162.243214874797;2164;2165.5560610074895;2170.2295685031822;2143.506993391521;2174.554216385637;2200.020990659157;2211.6903633491324;2214.2803588833613;2172.880491572963;2187.114218741412;2194.8353873459473;2195.3084778294788;2209.55808838233;2127.351157896841;2130.893455327235;2138.112683236455;2143.5391390850964;2144.0887622760265;2096.8846713430753;2113.7780533044115;2124.309599380192;2127.095984206706;2131.4564785979633;7994.760157195294;8039.115697273295;8044.879326810103;8060.476069055492;8072.959635201845;4295.312749960022;4378.255696531565;4444.35556844259;4449.065696203801;4452.998075433002;2816.084772448962;2847.658281006272;2891.277180704824;2902.3034471726633;2938.2213713365977;904.6517090919978;948.0566835998226;958.2046901072093;965.3146266151041;979.9951000244953;10578.947105264502;10676.839847402296;10680.946595266974;10701.732456688567;10703.250772445932;3890.980545097313;3931.8820435386983;4041.939370909439;4151.8962025949595;4174.144300418407;9024.548772561346;9169.633214671338;9181.173694367539;9208.12522810332;9212.401193922507;4390.363397307437;4398.516163222043;4401.6478681705385;4417.315316126005;4418.977905110518;3517.384457719889;3811.3901775715754;3897.006263402814;4043.91912161761;4052.858149964796;3623.2753449310244;3640.872569460056;3666.3400587894434;3681.392570225936;3750.868719594801;1165.7027457998156;1178.4461303187488;1183.6271574454192;1190.1609365397373;1192.5587532612988;678.3081257117713;695.937365637085;710.3393843725385;819.6024927909959;846.0989046665404;4878.341423907727;4921.360223170965;5145.24643495097;5151.5621172200035;5297.682139071668;409.61496193577943;414.0828065834192;416.90202802341423;420.1198489165194;424.39311784148964;3422.6748458896864;3429.1427143214196;3444.2422667013216;3550.5206797082064;3566.9477504136344;9240.168384845396;9762.316637835425;9790.363626364264;9797.412155270707;9803.656872009446;9529.809403811885;9540.3321767477;9731.513424328756;9833.557489912972;9898.158656514277;7384.040074790243;7446.925530744732;7447.069116360455;7448.255174482617;7483.326500614862;4944.283078953604;4964.851054468228;5004.499550045112;5031.572316353151;5322.175062865262;9076.364654474388;9117.452952822852;9151.359404841598;9211.309151813506;9251.306152038489;8617.655293788179;9034.954825225832;9038.502882341534;9136.08639136081;9310.581023854078;5811.651300921958;6541.476681865534;6720.529562930548;6840.726370945106;7037.824054398681;7663.348615367533;7774.533527988338;7801.843963120819;7814.257645523666;7817.491863028885;6849.931500684929;6990.825229369103;7013.403860671696;7047.224805271314;7136.536125151849;6497.4477169441125;6766.323367663194;6779.050932869501;6917.377436030782;6956;6015.879682406415;6029.1559181715475;6076.908846367396;6077.270727512727;6192.102145188832;4361.149575832682;4383.298672212431;4409.845655402046;4567.269236922077;4591.77041147948;4522.728636281834;4590.311453282035;4605.884852878705;4704.435467743892;4758.310045043519 12:34:51 INFO - PROCESS | 23334 | |4;prototype.html;281.8520276854651;286.34141474608396;296.3716920129326;297.7885701152182;301.39269372215006;4771.928421073687;4830.782614782334;4909.386326709161;5025.366755804369;5044.5207705267985;4885.8534243972645;4917.975410122954;4943.406791185053;4966.875828104299;4968.577670897969;3930.8034598270115;3940.349842276021;3951.4786807079195;3959.524857017162;3960.7425517341426;3587.5336206293277;3939.5075615548058;3950.7209016516367;3971.5432725236533;3973.98013009936;3753.831077601501;3765.1008723283194;3773.3019391412677;3781.8865434037025;3805.353089974697;3774.4338349247696;3777.9811100944594;3778.2254637799183;3794.1842503861803;3815.4467602197524;3310.635830058716;3339.231976645361;3339.933201335984;3343.281194543185;3350.2294472271515;4740.170470167707;4770.761461926924;4788.664793464459;4881.414230292387;4887.511248875119;4259.51015633203;4266.997255644921;4274.358846173068;4286.185624731291;4293.484781826201;5082.475257422759;5085.753990272407;5086.79652813887;5117.897642047175;5124.743762811881;3445.173158441981;3559.857605695769;3566.8394922228563;3574.8391322390294;3585.94621080684;5312.229726689647;5321.3348331458565;5325.4940780625775;5352.197170424429;5378.596605254622;3628.546431696038;3630.6550877666577;3632.7457078004813;3660.5790334111916;3662.688671462902;3700.16746232101;3736.065983504124;3737.495877761906;3742.681872040907;3752.874137758716;4167.517671849095;4281.314989601711;4294.828206871753;4311.417958575615;4328.285832837547;5119.539241468211;5130.410002849645;5131.846044618667;5133.871653208625;5138.3577052868395;1212.484694005062;1249.6126200877757;1277.6422601671547;1286.395394164741;1292.5652525696469;841.9727931923044;870.0733718589681;882.8719835623799;896.5562046786882;898.3621628643606;4548.408706868086;4550.385697930803;4556.589906908328;4558.544145585415;4560.635149188057;5220.686758794409;5261.76322065508;5270.732146069461;5272.6309158358545;5288.233206185082;4501.437320334958;4519.54804519552;4540.114677637895;4541.818327266872;4578.184416583844;2672.559027760398;2813.6213255505063;2841.5169421198448;2851.8574071296352;2861.5850701648146;5059.772310246048;5089.592832573459;5092.021167616912;5104.9489505104475;5128.512791284822;5249.291345668286;5411.485908838654;5480.287562616834;5480.287562616834;5487.862803429946;5072.873178170576;5075.28945947575;5075.441701412841;5075.705695047739;5092.770825312796;5336.146216605324;5349.709928394088;5354.3842458117815;5366.463353664759;5370.462953704755;5040.596752259884;5204.799048585017;5206.375234971828;5216.947830521646;5233.371995360581;5077.7968881245815;5096.159133742891;5097.8725531862;5106.923396148986;5118.206677964921;3633.6184700606054;3654.8355324009954;3695.796731179811;3697.186618943828;3697.4638677392168;5184;5253.23828044939;5259.347416443427;5367.758450869642;5387.407385187548;5150.742462876916;5156.690598564098;5157.252198431132;5165.61257905651;5189.636725429184;5128.8717782054255;5130.153524668537;5136.8202112925865;5150.098732721834;5151.14558758854;4829.927551086666;5073.44192138857;5097.643164978416;5112.335396398445;5144.408393034849;5152.639315247897;5182.24857395668;5199.4540573239265;5199.506046925536;5243.528082472596;5106.770195341144;5119.308893299506;5120.18077107661;5125.7693403796175;5127.794888204579 12:34:51 INFO - PROCESS | 23334 | |5;yui.html;591.8816236752648;601.2034054877288;605.5488660947594;610.2615834839844;726.7238449389231;12231.266124032552;12706.555270565532;13184.538541151062;13195.934020329896;13216.405261763231;13935.860641393583;14618.707625847503;14692.779608305884;14720.484783032596;14781.408743650269;754.6717178027549;779.0612312163857;779.8479296537178;783.9529628222325;784.2667106255641;616.4852348289184;746.0972223609411;770.7456539342031;776.8718161503346;783.2872086401376;807.5275963561323;810.3152835853724;812.9187081291853;815.0260438775665;815.8001289684006;804.9879251811199;807.4065561812092;808.1756608259572;809.4253080312985;811.395510344791;591.7514643849594;594.6699581732137;596.6241268001131;597.2444857255575;597.901346277868;12269.631911042683;12325.815112773316;12364.072694547946;12365;12367.257964522158;12951.740965180643;13260.668483287898;13431.798523022162;13456.394462249222;13696.178229306273;10318.793624127475;10636.30863993838;10736.570537178504;10836.0789332906;10842.169433257077;3211.96788032119;3212.389645967282;3214.9678503214905;3244.707976282122;3252.9837350813095;53054;55238.17142742862;55624.44375556233;61004.38995609987;67233;9508.857367139499;9791.118799307955;9891.802163956681;9951.959848231096;10248.897511024794;18206.271749129886;18464.446066618024;18537.165827537792;18669.813301867078;18770;6165.32181460039;6536.803895883036;6814.080099186546;6903.792886213421;7021.5787052777;3673.1000904778502;3683.8710645127826;3740.6259374062374;3789.4694742736037;3801.2777572261184;2837.3615936414553;2953.896613618513;2981.985090074536;2984.4031193761334;2988.1633142720075;502.48495292325657;502.8692539939569;504.4148787406664;505.7092172001114;506.6200349737697;592.1502643706295;595.4164918379926;609.4697613076563;616.8797084568466;624.2758400255682;8090.110087890327;8133.471324363897;8413.915860841436;8473.322134229247;8701.564921753887;485.0292894469097;490.5903570518586;616.0758861707438;627.3569591169088;630.4735545819292;3880.9223815524097;4031.395290706359;4281.657467402601;4339.153864996359;4404.339349097597;99673.50163249137;101470;102669.48665256627;102770.48614756878;107411;73747.63126184334;82875;88473;88739;89270;60693.39306606878;67914;68573;69617.30382696108;71302;7754.457187997012;8598.914010860062;8700.434471759316;8899.243564297107;8996.820063598821;40894.97762555841;42636;43389.566104338555;43847.78076109599;44007.77996109999;63563.682181588796;63592;63677.681611591644;63928.16431014154;63933.680331599906;10317.432541210306;10938.289011214245;11049.72375690582;11152.832707509231;11653.883461165618;12858.807117893426;13016.804747928978;13093.738125237633;13187.340632968506;13824.930875345559;10052.547635356574;11762.176647634926;11992.040636749214;12754.87245127574;12814.038947079192;11702.4733886977;11961.342126183143;12330.445129969352;12334;12390.752184956431;10703.839442408214;10839.620613278497;11243.4378281084;11296.209265351346;11370.260933039657;9283.798470481554;9408;9519.190868775955;9523.904760952302;9799.268071358181;8952.776180595538;9286.767830804283;9329.440233586007;9751.268654850772;10331.535080921527 12:34:51 INFO - PROCESS | 23334 | __end_tp_report 12:34:51 INFO - PROCESS | 23334 | __start_cc_report 12:34:51 INFO - PROCESS | 23334 | _x_x_mozilla_cycle_collect,396 12:34:51 INFO - PROCESS | 23334 | __end_cc_report 12:34:51 INFO - PROCESS | 23334 | __startTimestamp1471894491846__endTimestamp 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | ------- Summary: start ------- 12:34:51 INFO - PROCESS | 23334 | Number of tests: 6 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | [#0] dojo.html Cycles:165 Average:4731.27 Median:4907.36 stddev:510.71 (10.4%) stddev-sans-first:484.30 12:34:51 INFO - PROCESS | 23334 | Values: 2606.2 2624.0 2631.7 2640.2 2642.5 4633.0 4723.6 4750.6 4798.8 4808.5 4694.6 4738.8 4740.0 4741.0 4782.8 4254.6 4379.8 4417.6 4527.8 4528.0 4459.5 4463.3 4515.1 4525.1 4528.4 4205.1 4328.6 4377.7 4391.1 4458.4 4437.4 4442.7 4447.5 4455.6 4467.0 4372.9 4400.0 4429.7 4431.0 4442.4 4652.0 4783.8 4786.6 4836.4 4869.6 5196.6 5213.6 5218.4 5221.7 5242.1 4981.1 5144.8 5146.1 5151.2 5152.9 4661.6 4740.0 4757.5 4761.7 4763.9 5210.6 5211.9 5214.1 5214.9 5215.7 4858.2 5000.6 5001.4 5006.4 5014.0 4912.5 4978.7 5029.4 5048.8 5099.8 5054.8 5056.5 5069.9 5113.7 5123.1 4907.4 5089.0 5095.1 5107.7 5108.0 4130.1 4182.5 4209.5 4219.3 4255.0 3710.4 3712.4 3718.4 3719.9 3740.2 4348.3 4399.8 4411.6 4440.2 4447.5 5005.7 5067.3 5090.6 5134.9 5136.5 4438.3 4458.8 4468.7 4472.4 4483.8 4505.0 4583.9 4590.1 4593.1 4597.0 4935.8 4947.4 4956.8 4960.9 4970.1 5204.7 5218.9 5220.7 5224.5 5228.5 4783.8 4885.2 4891.6 4963.5 4963.5 5086.3 5089.3 5094.2 5115.1 5115.9 5196.0 5201.2 5203.0 5204.8 5206.3 4822.6 4846.6 4947.4 4987.3 5044.1 4933.9 4983.4 4996.5 5003.5 5009.5 4956.6 4968.0 4980.0 4981.9 4982.3 4887.0 4942.7 5008.4 5074.2 5086.7 4951.1 4956.5 4961.6 4970.1 4972.6 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | [#1] ext.html Cycles:180 Average:46660.04 Median:19806.99 stddev:87296.92 (440.7%) stddev-sans-first:87473.13 12:34:51 INFO - PROCESS | 23334 | Values: 536.5 540.8 558.6 559.4 560.4 34215.5 38094.0 38095.4 38102.0 38182.6 37902.2 38376.0 38450.0 38458.8 38517.2 7529.4 7636.3 7649.9 7652.2 7667.8 7663.7 7726.7 7749.3 7766.5 7783.8 7693.3 7740.0 7754.7 7759.5 7764.4 7728.3 7759.0 7760.5 7761.1 7778.1 7563.7 7575.1 7626.6 7646.0 7649.6 36489.8 36662.5 36698.4 36837.6 36944.4 2749.3 2840.2 2916.5 3070.8 3260.2 27893.3 27906.4 28230.7 28342.9 31248.7 3461.1 3520.7 3570.1 3583.7 3613.2 266612.0 268720.0 268824.0 269151.0 269164.0 30052.0 52162.5 52393.0 52488.5 52567.7 30972.0 32568.0 32612.3 32721.5 32750.0 12216.8 12319.2 12336.6 12355.6 12408.6 10033.1 10093.8 10101.5 10138.4 10149.3 7695.8 7708.0 7761.4 7804.2 7814.7 3063.9 3064.1 3089.7 3093.2 3107.5 815.9 892.8 944.7 977.0 987.9 27927.4 28350.0 28669.4 28834.3 29131.4 841.3 928.1 958.4 1009.7 1070.7 13993.7 14849.3 14957.2 15186.5 15217.3 380441.0 383875.0 384455.0 384778.0 385839.0 47033.0 47369.5 47523.3 47615.8 47728.3 1140.6 1164.4 1181.9 1183.8 1188.1 26805.8 27658.6 27904.7 28203.3 28421.6 41874.0 42000.2 42085.4 42207.0 42216.0 328454.0 328572.0 329043.0 331306.0 331807.0 24832.5 25093.6 25093.7 25223.4 25257.4 40026.0 41159.6 41234.2 41617.4 42581.6 35322.0 35984.5 36279.3 36720.0 36733.8 35691.0 36420.5 37239.0 37804.0 37819.6 34727.7 35300.0 35402.9 35534.5 36000.8 30337.7 32886.3 33240.7 33335.0 33373.0 25583.4 25602.9 25744.4 26152.4 26345.0 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | [#2] jquery.html Cycles:180 Average:23363.60 Median:4325.44 stddev:63318.04 (1463.9%) stddev-sans-first:63472.09 12:34:51 INFO - PROCESS | 23334 | Values: 352.6 360.8 367.6 375.0 378.2 15687.5 16247.2 17099.4 17174.7 17223.7 12878.9 14828.7 14954.3 15859.1 16316.5 4616.0 4921.5 4924.0 4950.1 5001.6 4831.6 4952.2 4957.0 4962.0 5007.7 4700.1 4803.9 4866.9 4869.5 4921.1 4893.1 4915.3 4953.1 4953.1 4958.7 4176.3 4316.7 4334.2 4353.0 4391.5 19734.0 20117.2 20226.4 20227.9 20352.5 1891.9 1923.7 2008.4 2196.3 2240.8 12802.0 12989.9 13100.3 13321.1 13571.3 1682.3 1757.8 1779.9 1781.9 1789.9 41752.6 42838.1 45766.5 59643.7 59941.7 9136.8 9175.0 9247.6 9389.8 9496.4 12788.7 12831.7 12842.5 12856.9 12891.8 6758.5 6818.9 6916.0 6936.7 6954.7 6366.4 6444.2 6455.4 6605.2 6637.0 5696.3 5822.9 5932.7 5997.0 6145.7 1765.1 1799.7 1803.3 1804.0 1812.1 849.5 860.3 950.4 958.8 1011.0 16548.0 17629.6 17630.5 17911.4 17997.6 838.7 846.7 873.5 895.2 940.6 9397.4 10063.3 10089.9 10165.8 10172.3 376878.0 379967.0 384564.0 385700.0 401593.0 67314.3 68316.0 69424.7 70648.6 71360.6 909.5 922.2 943.3 949.9 955.5 15024.8 15164.2 15327.4 15582.8 15815.8 34870.5 35380.8 35459.3 35809.8 35921.5 50428.5 51248.5 53077.0 54898.5 55085.2 7176.7 7224.2 7367.2 7526.7 7647.7 8585.9 10819.5 10920.6 10930.5 11170.1 9742.8 10051.3 10106.4 10594.0 10863.7 9082.6 9330.1 9384.1 9389.9 9424.5 9890.5 10111.6 10186.3 10332.2 10529.3 7304.0 7329.2 7361.7 7401.1 7487.1 10093.4 10468.3 10604.8 10756.8 10880.5 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | [#3] mootools.html Cycles:180 Average:5114.33 Median:4899.85 stddev:2945.53 (60.1%) stddev-sans-first:2940.12 12:34:51 INFO - PROCESS | 23334 | Values: 1338.1 1389.8 1438.5 1622.8 1647.3 6718.5 7504.4 7589.0 8064.5 8098.6 7611.9 7876.3 7890.4 7891.3 7944.0 2118.2 2162.2 2164.0 2165.6 2170.2 2143.5 2174.6 2200.0 2211.7 2214.3 2172.9 2187.1 2194.8 2195.3 2209.6 2127.4 2130.9 2138.1 2143.5 2144.1 2096.9 2113.8 2124.3 2127.1 2131.5 7994.8 8039.1 8044.9 8060.5 8073.0 4295.3 4378.3 4444.4 4449.1 4453.0 2816.1 2847.7 2891.3 2902.3 2938.2 904.7 948.1 958.2 965.3 980.0 10578.9 10676.8 10680.9 10701.7 10703.3 3891.0 3931.9 4041.9 4151.9 4174.1 9024.5 9169.6 9181.2 9208.1 9212.4 4390.4 4398.5 4401.6 4417.3 4419.0 3517.4 3811.4 3897.0 4043.9 4052.9 3623.3 3640.9 3666.3 3681.4 3750.9 1165.7 1178.4 1183.6 1190.2 1192.6 678.3 695.9 710.3 819.6 846.1 4878.3 4921.4 5145.2 5151.6 5297.7 409.6 414.1 416.9 420.1 424.4 3422.7 3429.1 3444.2 3550.5 3566.9 9240.2 9762.3 9790.4 9797.4 9803.7 9529.8 9540.3 9731.5 9833.6 9898.2 7384.0 7446.9 7447.1 7448.3 7483.3 4944.3 4964.9 5004.5 5031.6 5322.2 9076.4 9117.5 9151.4 9211.3 9251.3 8617.7 9035.0 9038.5 9136.1 9310.6 5811.7 6541.5 6720.5 6840.7 7037.8 7663.3 7774.5 7801.8 7814.3 7817.5 6849.9 6990.8 7013.4 7047.2 7136.5 6497.4 6766.3 6779.1 6917.4 6956.0 6015.9 6029.2 6076.9 6077.3 6192.1 4361.1 4383.3 4409.8 4567.3 4591.8 4522.7 4590.3 4605.9 4704.4 4758.3 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | [#4] prototype.html Cycles:180 Average:4275.24 Median:4930.69 stddev:1259.04 (25.5%) stddev-sans-first:1226.38 12:34:51 INFO - PROCESS | 23334 | Values: 281.9 286.3 296.4 297.8 301.4 4771.9 4830.8 4909.4 5025.4 5044.5 4885.9 4918.0 4943.4 4966.9 4968.6 3930.8 3940.3 3951.5 3959.5 3960.7 3587.5 3939.5 3950.7 3971.5 3974.0 3753.8 3765.1 3773.3 3781.9 3805.4 3774.4 3778.0 3778.2 3794.2 3815.4 3310.6 3339.2 3339.9 3343.3 3350.2 4740.2 4770.8 4788.7 4881.4 4887.5 4259.5 4267.0 4274.4 4286.2 4293.5 5082.5 5085.8 5086.8 5117.9 5124.7 3445.2 3559.9 3566.8 3574.8 3585.9 5312.2 5321.3 5325.5 5352.2 5378.6 3628.5 3630.7 3632.7 3660.6 3662.7 3700.2 3736.1 3737.5 3742.7 3752.9 4167.5 4281.3 4294.8 4311.4 4328.3 5119.5 5130.4 5131.8 5133.9 5138.4 1212.5 1249.6 1277.6 1286.4 1292.6 842.0 870.1 882.9 896.6 898.4 4548.4 4550.4 4556.6 4558.5 4560.6 5220.7 5261.8 5270.7 5272.6 5288.2 4501.4 4519.5 4540.1 4541.8 4578.2 2672.6 2813.6 2841.5 2851.9 2861.6 5059.8 5089.6 5092.0 5104.9 5128.5 5249.3 5411.5 5480.3 5480.3 5487.9 5072.9 5075.3 5075.4 5075.7 5092.8 5336.1 5349.7 5354.4 5366.5 5370.5 5040.6 5204.8 5206.4 5216.9 5233.4 5077.8 5096.2 5097.9 5106.9 5118.2 3633.6 3654.8 3695.8 3697.2 3697.5 5184.0 5253.2 5259.3 5367.8 5387.4 5150.7 5156.7 5157.3 5165.6 5189.6 5128.9 5130.2 5136.8 5150.1 5151.1 4829.9 5073.4 5097.6 5112.3 5144.4 5152.6 5182.2 5199.5 5199.5 5243.5 5106.8 5119.3 5120.2 5125.8 5127.8 12:34:51 INFO - PROCESS | 23334 | 12:34:51 INFO - PROCESS | 23334 | [#5] yui.html Cycles:180 Average:17626.38 Median:505.06 stddev:25301.65 (5009.6%) stddev-sans-first:25340.30 12:34:51 INFO - PROCESS | 23334 | Values: 591.9 601.2 605.5 610.3 726.7 12231.3 12706.6 13184.5 13195.9 13216.4 13935.9 14618.7 14692.8 14720.5 14781.4 754.7 779.1 779.8 784.0 784.3 616.5 746.1 770.7 776.9 783.3 807.5 810.3 812.9 815.0 815.8 805.0 807.4 808.2 809.4 811.4 591.8 594.7 596.6 597.2 597.9 12269.6 12325.8 12364.1 12365.0 12367.3 12951.7 13260.7 13431.8 13456.4 13696.2 10318.8 10636.3 10736.6 10836.1 10842.2 3212.0 3212.4 3215.0 3244.7 3253.0 53054.0 55238.2 55624.4 61004.4 67233.0 9508.9 9791.1 9891.8 9952.0 10248.9 18206.3 18464.4 18537.2 18669.8 18770.0 6165.3 6536.8 6814.1 6903.8 7021.6 3673.1 3683.9 3740.6 3789.5 3801.3 2837.4 2953.9 2982.0 2984.4 2988.2 502.5 502.9 504.4 505.7 506.6 592.2 595.4 609.5 616.9 624.3 8090.1 8133.5 8413.9 8473.3 8701.6 485.0 490.6 616.1 627.4 630.5 3880.9 4031.4 4281.7 4339.2 4404.3 99673.5 101470.0 102669.5 102770.5 107411.0 73747.6 82875.0 88473.0 88739.0 89270.0 60693.4 67914.0 68573.0 69617.3 71302.0 7754.5 8598.9 8700.4 8899.2 8996.8 40895.0 42636.0 43389.6 43847.8 44007.8 63563.7 63592.0 63677.7 63928.2 63933.7 10317.4 10938.3 11049.7 11152.8 11653.9 12858.8 13016.8 13093.7 13187.3 13824.9 10052.5 11762.2 11992.0 12754.9 12814.0 11702.5 11961.3 12330.4 12334.0 12390.8 10703.8 10839.6 11243.4 11296.2 11370.3 9283.8 9408.0 9519.2 9523.9 9799.3 8952.8 9286.8 9329.4 9751.3 10331.5 12:34:51 INFO - PROCESS | 23334 | -------- Summary: end -------- 12:34:51 INFO - PROCESS | 23334 | 12:34:52 INFO - TEST-INFO | 23334: exit 0 12:34:52 INFO - TEST-OK | dromaeo_css | took 1119762ms 12:34:52 INFO - TEST-START | kraken 12:34:52 INFO - operating with platform_type : linux_ 12:34:52 INFO - Initialising browser for kraken test... 12:34:52 INFO - TEST-INFO | started process 23696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTx9Px6/profile http://localhost:46737/getInfo.html) 12:34:58 INFO - PROCESS | 23696 | __metrics Screen width/height:1600/1200 12:34:58 INFO - PROCESS | 23696 | colorDepth:24 12:34:58 INFO - PROCESS | 23696 | Browser inner width/height: 1024/697 12:34:58 INFO - PROCESS | 23696 | __metrics 12:34:59 ERROR - PROCESS | 23696 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 12:35:00 INFO - TEST-INFO | 23696: exit 0 12:35:00 INFO - Browser initialized. 12:35:00 INFO - Running cycle 1/1 for kraken test... 12:35:00 INFO - TEST-INFO | started process 23814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTx9Px6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:12 INFO - PROCESS | 23814 | RSS: Main: 187719680 12:35:12 INFO - PROCESS | 23814 | 12:35:15 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46737/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:16 INFO - PROCESS | 23814 | RSS: Main: 200695808 12:35:16 INFO - PROCESS | 23814 | 12:35:19 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46737/tests/kraken/driver.html?testName=audio-dft) 12:35:19 INFO - PROCESS | 23814 | RSS: Main: 199278592 12:35:19 INFO - PROCESS | 23814 | 12:35:22 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46737/tests/kraken/driver.html?testName=audio-fft) 12:35:23 INFO - PROCESS | 23814 | RSS: Main: 196059136 12:35:23 INFO - PROCESS | 23814 | 12:35:25 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46737/tests/kraken/driver.html?testName=audio-oscillator) 12:35:26 INFO - PROCESS | 23814 | RSS: Main: 196837376 12:35:26 INFO - PROCESS | 23814 | 12:35:28 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:29 INFO - PROCESS | 23814 | RSS: Main: 196943872 12:35:29 INFO - PROCESS | 23814 | 12:35:32 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46737/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:33 INFO - PROCESS | 23814 | RSS: Main: 196677632 12:35:33 INFO - PROCESS | 23814 | 12:35:36 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46737/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:37 INFO - PROCESS | 23814 | RSS: Main: 195399680 12:35:37 INFO - PROCESS | 23814 | 12:35:40 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46737/tests/kraken/driver.html?testName=json-parse-financial) 12:35:41 INFO - PROCESS | 23814 | RSS: Main: 196501504 12:35:41 INFO - PROCESS | 23814 | 12:35:43 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:43 INFO - PROCESS | 23814 | RSS: Main: 196481024 12:35:43 INFO - PROCESS | 23814 | 12:35:45 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:46 INFO - PROCESS | 23814 | RSS: Main: 196517888 12:35:46 INFO - PROCESS | 23814 | 12:35:48 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:49 INFO - PROCESS | 23814 | RSS: Main: 197156864 12:35:49 INFO - PROCESS | 23814 | 12:35:52 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:52 INFO - PROCESS | 23814 | RSS: Main: 197222400 12:35:52 INFO - PROCESS | 23814 | 12:35:55 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:56 INFO - PROCESS | 23814 | RSS: Main: 197177344 12:35:56 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | Cycle 1(1): loaded http://localhost:46737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46737/tests/kraken/driver.html?testName=ai-astar) 12:35:58 INFO - PROCESS | 23814 | RSS: Main: 200302592 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | __start_tp_report 12:35:58 INFO - PROCESS | 23814 | _x_x_mozilla_page_load 12:35:58 INFO - PROCESS | 23814 | _x_x_mozilla_page_load_details 12:35:58 INFO - PROCESS | 23814 | |i|pagename|runs| 12:35:58 INFO - PROCESS | 23814 | |0;ai-astar;109;118;112;117;115;116;125;115;116;119 12:35:58 INFO - PROCESS | 23814 | |1;audio-beat-detection;167;124;159;185;127;156;156;144;189;128 12:35:58 INFO - PROCESS | 23814 | |2;audio-dft;170;169;164;166;167;168;167;169;163;165 12:35:58 INFO - PROCESS | 23814 | |3;audio-fft;78;78;78;172;79;82;80;76;174;79 12:35:58 INFO - PROCESS | 23814 | |4;audio-oscillator;88;90;147;88;89;88;133;88;90;140 12:35:58 INFO - PROCESS | 23814 | |5;imaging-gaussian-blur;125;118;119;119;130;120;121;120;119;119 12:35:58 INFO - PROCESS | 23814 | |6;imaging-darkroom;161;155;148;147;150;148;148;150;152;149 12:35:58 INFO - PROCESS | 23814 | |7;imaging-desaturate;97;97;96;111;96;97;96;97;97;96 12:35:58 INFO - PROCESS | 23814 | |8;json-parse-financial;70;71;69;72;66;65;66;65;67;67 12:35:58 INFO - PROCESS | 23814 | |9;json-stringify-tinderbox;66;70;66;70;67;67;67;66;66;68 12:35:58 INFO - PROCESS | 23814 | |10;stanford-crypto-aes;86;84;86;84;89;85;92;88;86;85 12:35:58 INFO - PROCESS | 23814 | |11;stanford-crypto-ccm;154;149;142;144;138;160;148;149;169;143 12:35:58 INFO - PROCESS | 23814 | |12;stanford-crypto-pbkdf2;175;180;176;197;175;183;175;178;180;181 12:35:58 INFO - PROCESS | 23814 | |13;stanford-crypto-sha256-iterative;71;71;73;77;73;75;74;71;71;73 12:35:58 INFO - PROCESS | 23814 | __end_tp_report 12:35:58 INFO - PROCESS | 23814 | __start_cc_report 12:35:58 INFO - PROCESS | 23814 | _x_x_mozilla_cycle_collect,955 12:35:58 INFO - PROCESS | 23814 | __end_cc_report 12:35:58 INFO - PROCESS | 23814 | __startTimestamp1471894558624__endTimestamp 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | ------- Summary: start ------- 12:35:58 INFO - PROCESS | 23814 | Number of tests: 14 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.50 stddev:4.24 (3.6%) stddev-sans-first:3.61 12:35:58 INFO - PROCESS | 23814 | Values: 109.0 118.0 112.0 117.0 115.0 116.0 125.0 115.0 116.0 119.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:157.50 stddev:23.07 (14.6%) stddev-sans-first:23.95 12:35:58 INFO - PROCESS | 23814 | Values: 167.0 124.0 159.0 185.0 127.0 156.0 156.0 144.0 189.0 128.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#2] audio-dft Cycles:10 Average:166.80 Median:167.50 stddev:2.30 (1.4%) stddev-sans-first:2.13 12:35:58 INFO - PROCESS | 23814 | Values: 170.0 169.0 164.0 166.0 167.0 168.0 167.0 169.0 163.0 165.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#3] audio-fft Cycles:10 Average:97.60 Median:78.50 stddev:39.77 (50.7%) stddev-sans-first:41.55 12:35:58 INFO - PROCESS | 23814 | Values: 78.0 78.0 78.0 172.0 79.0 82.0 80.0 76.0 174.0 79.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:88.00 stddev:25.00 (28.4%) stddev-sans-first:25.83 12:35:58 INFO - PROCESS | 23814 | Values: 88.0 90.0 147.0 88.0 89.0 88.0 133.0 88.0 90.0 140.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#5] imaging-gaussian-blur Cycles:10 Average:121.00 Median:120.00 stddev:3.71 (3.1%) stddev-sans-first:3.64 12:35:58 INFO - PROCESS | 23814 | Values: 125.0 118.0 119.0 119.0 130.0 120.0 121.0 120.0 119.0 119.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.00 stddev:4.29 (2.9%) stddev-sans-first:2.50 12:35:58 INFO - PROCESS | 23814 | Values: 161.0 155.0 148.0 147.0 150.0 148.0 148.0 150.0 152.0 149.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:97.00 stddev:4.59 (4.7%) stddev-sans-first:4.86 12:35:58 INFO - PROCESS | 23814 | Values: 97.0 97.0 96.0 111.0 96.0 97.0 96.0 97.0 97.0 96.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:68.00 stddev:2.53 (3.7%) stddev-sans-first:2.55 12:35:58 INFO - PROCESS | 23814 | Values: 70.0 71.0 69.0 72.0 66.0 65.0 66.0 65.0 67.0 67.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:1.57 (2.3%) stddev-sans-first:1.59 12:35:58 INFO - PROCESS | 23814 | Values: 66.0 70.0 66.0 70.0 67.0 67.0 67.0 66.0 66.0 68.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.51 (2.9%) stddev-sans-first:2.65 12:35:58 INFO - PROCESS | 23814 | Values: 86.0 84.0 86.0 84.0 89.0 85.0 92.0 88.0 86.0 85.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:149.00 stddev:9.28 (6.2%) stddev-sans-first:9.70 12:35:58 INFO - PROCESS | 23814 | Values: 154.0 149.0 142.0 144.0 138.0 160.0 148.0 149.0 169.0 143.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:180.00 stddev:6.62 (3.7%) stddev-sans-first:6.77 12:35:58 INFO - PROCESS | 23814 | Values: 175.0 180.0 176.0 197.0 175.0 183.0 175.0 178.0 180.0 181.0 12:35:58 INFO - PROCESS | 23814 | 12:35:58 INFO - PROCESS | 23814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:2.02 (2.8%) stddev-sans-first:2.03 12:35:58 INFO - PROCESS | 23814 | Values: 71.0 71.0 73.0 77.0 73.0 75.0 74.0 71.0 71.0 73.0 12:35:58 INFO - PROCESS | 23814 | -------- Summary: end -------- 12:35:58 INFO - PROCESS | 23814 | 12:35:59 INFO - TEST-INFO | 23814: exit 0 12:35:59 INFO - TEST-OK | kraken | took 66932ms 12:35:59 INFO - SUITE-END | took 1186s 12:36:00 INFO - Completed test suite (00:19:47) 12:36:00 INFO - javascript benchmark 12:36:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6296.144394980235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.2441891851363, 2623.9868800655995, 2631.657884475018, 2640.1815437214477, 2642.4715056988607, 4632.976835115828, 4723.598494127999, 4750.619950403964, 4798.808047678093, 4808.543188397105, 4694.6244300455965, 4738.834140805073, 4740.0, 4740.9762951185285, 4782.7847746851385, 4254.638355739766, 4379.781010949448, 4417.558244175589, 4527.750973696446, 4528.026474308023, 4459.464864216298, 4463.285874260119, 4515.074409745994, 4525.140223357552, 4528.411306530146, 4205.095904380542, 4328.63206627437, 4377.693561450668, 4391.055922976575, 4458.398116254297, 4437.4009508716235, 4442.689011769177, 4447.510773814878, 4455.598996090335, 4466.977665111686, 4372.912541749179, 4399.978000110011, 4429.712068715556, 4430.977845110754, 4442.42248507692, 4651.953480465186, 4783.784729687138, 4786.64100192487, 4836.419629644465, 4869.586085182764, 5196.58427325813, 5213.608979326527, 5218.399884013349, 5221.686698798084, 5242.056429842627, 4981.078500477423, 5144.819931302386, 5146.073706732786, 5151.227315902607, 5152.9484705152845, 4661.557152070548, 4739.95260047402, 4757.500462451462, 4761.714297142183, 4763.928541071887, 5210.557102646318, 5211.895762084737, 5214.139666954986, 5214.921776173361, 5215.687058776485, 4858.17411040124, 5000.64995450315, 5001.399832020181, 5006.3992320921725, 5013.997200559903, 4912.526242127347, 4978.726170060681, 5029.421616514074, 5048.823291184791, 5099.821506247264, 5054.772535235923, 5056.494350564914, 5069.949300506948, 5113.693178409308, 5123.052235336475, 4907.362042934467, 5089.033083714083, 5095.0828850806465, 5107.719075450886, 5108.0, 4130.050088479667, 4182.477190351206, 4209.473815773028, 4219.346001369792, 4255.0426154115075, 3710.350688629479, 3712.387456069718, 3718.3864662330952, 3719.888403347904, 3740.214554943438, 4348.2825333819565, 4399.824007039682, 4411.647068234533, 4440.178566965122, 4447.533009034005, 5005.699658020458, 5067.265246539231, 5090.643654944119, 5134.897302053938, 5136.4606716295, 4438.267685831802, 4458.777061146994, 4468.731876087445, 4472.373867658531, 4483.820647174077, 4504.954950450519, 4583.9083218335445, 4590.104929538707, 4593.081383723269, 4597.0, 4935.753212339297, 4947.35684361038, 4956.752162391938, 4960.8759781005765, 4970.055689418999, 5204.713740744295, 5218.8956220876125, 5220.738963051908, 5224.477552244745, 5228.451012643618, 4783.832565860317, 4885.169521181337, 4891.63312751538, 4963.478834722302, 4963.528464795983, 5086.262491938722, 5089.338386009795, 5094.184930411265, 5115.130427827204, 5115.897682046412, 5196.012757576049, 5201.193814958688, 5203.037438073969, 5204.791808327776, 5206.323177986837, 4822.614190864652, 4846.61227101824, 4947.381577302837, 4987.301777751045, 5044.1172794761505, 4933.901321973469, 4983.426905905867, 4996.475370086088, 5003.474635163401, 5009.474005229398, 4956.603471722326, 4967.975160124176, 4979.975100124476, 4981.850544483671, 4982.252662100714, 4886.998165376161, 4942.678725882806, 5008.4240312364545, 5074.213496907985, 5086.720230387365, 4951.059298733229, 4956.504349565014, 4961.578265847444, 4970.130227210296, 4972.627052971114], "value": 4697.471660483051, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.4581772409867, 540.8107162493128, 558.5643198305321, 559.4461483131698, 560.43676105514, 34215.4867676985, 38093.99999999996, 38095.42856857149, 38102.0, 38182.61817381826, 37902.241955160884, 38376.0, 38450.0, 38458.8077059615, 38517.22965540695, 7529.397648188132, 7636.312731854132, 7649.885251721229, 7652.19651936547, 7667.769966901002, 7663.693452261903, 7726.690932362699, 7749.341305988998, 7766.495177813424, 7783.766487005399, 7693.346065584432, 7739.961300193491, 7754.651040703154, 7759.45683802134, 7764.37884969204, 7728.26581474759, 7758.991331126946, 7760.534367937942, 7761.068671759369, 7778.105517865405, 7563.697452101965, 7575.0909890813455, 7626.580538070404, 7646.0, 7649.579273139975, 36489.81755091234, 36662.450063249074, 36698.4495232569, 36837.631623683956, 36944.44583331252, 2749.3422032467815, 2840.247334456371, 2916.47503449379, 3070.7850450468477, 3260.168656992452, 27893.302667433476, 27906.441871162464, 28230.717692823015, 28342.858285708644, 31248.687513124805, 3461.13471632092, 3520.68313851752, 3570.125319296789, 3583.7491375603718, 3613.1689711366535, 266612.0, 268720.0, 268824.0, 269151.0, 269164.0, 30052.0, 52162.47837521576, 52393.0, 52488.47511524912, 52567.73716131395, 30972.0, 32568.0, 32612.347753044807, 32721.509177362357, 32750.0, 12216.816747748791, 12319.199252048587, 12336.568220112253, 12355.567555135527, 12408.56570020045, 10033.147182489423, 10093.798124037477, 10101.494925253855, 10138.391696498235, 10149.34029288094, 7695.846083078307, 7707.961460192663, 7761.4178936578855, 7804.180561041123, 7814.726484573012, 3063.9234019149253, 3064.0960916529675, 3089.6601373848857, 3093.2421556718746, 3107.533869919485, 815.9224873636995, 892.8258989496986, 944.6740874398322, 976.9853452198223, 987.8666380038603, 27927.441451170864, 28350.0, 28669.426611467654, 28834.27914302159, 29131.35858017748, 841.3143288220081, 928.1182876267438, 958.3722661656626, 1009.7172791618359, 1070.710908054821, 13993.72012559743, 14849.331780069922, 14957.177355245565, 15186.468473603592, 15217.31522081509, 380441.0, 383875.0, 384455.0, 384778.0, 385839.0, 47033.0, 47369.52630473651, 47523.28715069277, 47615.76192119087, 47728.28407573889, 1140.6235942139074, 1164.3596022187762, 1181.9054475641929, 1183.8461000069935, 1188.0554958807595, 26805.803359471785, 27658.5851212236, 27904.720952790212, 28203.2949176264, 28421.57367639446, 41874.0, 42000.15999679928, 42085.36871946862, 42207.0, 42216.0, 328454.0, 328572.0, 329043.0, 331306.0, 331807.0, 24832.50334993326, 25093.623595646444, 25093.74906250914, 25223.36941576475, 25257.368565785266, 40026.0, 41159.588404116774, 41234.1753164929, 41617.37573936333, 42581.57418425776, 35322.0, 35984.460233096004, 36279.27441451209, 36720.0, 36733.816330919246, 35691.0, 36420.45369319515, 37239.0, 37804.0, 37819.62180378271, 34727.65272347244, 35300.0, 35402.93791186268, 35534.46698299476, 36000.8199959009, 30337.696623033487, 32886.342273153925, 33240.66759332376, 33335.0, 33373.0, 25583.360415989748, 25602.87198563995, 25744.356391089623, 26152.42332591827, 26345.0], "value": 16238.421385905775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.6033212635785, 360.81959020489757, 367.63053131602743, 374.9837939184809, 378.21520345283545, 15687.52937411878, 16247.187640617965, 17099.40152094677, 17174.656506869855, 17223.655526889455, 12878.871211287884, 14828.703425931475, 14954.32705528251, 15859.127747973856, 16316.51050468485, 4615.999999999992, 4921.507849215086, 4923.9753801230945, 4950.133726597849, 5001.624878134136, 4831.589314908237, 4952.232403977389, 4956.950430495685, 4962.0, 5007.7496125193775, 4700.106979673868, 4803.927941080887, 4866.853994380156, 4869.4887036861155, 4921.089598424285, 4893.119238537062, 4915.2872833439305, 4953.0589188054155, 4953.108440480712, 4958.727270000149, 4176.331786914109, 4316.69783115179, 4334.176506463793, 4352.956470435319, 4391.451068616423, 19734.0, 20117.195312187494, 20226.39320820378, 20227.89886050575, 20352.491187720276, 1891.933782317626, 1923.7114432835047, 2008.4275981345247, 2196.3081629286726, 2240.7759224077463, 12802.0, 12989.935050324688, 13100.279484628341, 13321.134126281857, 13571.321433928362, 1682.3186609423203, 1757.8242175782448, 1779.88430752002, 1781.910904454785, 1789.8836575622543, 41752.58247417517, 42838.14323713508, 45766.54233457656, 59643.70178149082, 59941.700291498266, 9136.81726365469, 9175.0, 9247.583858726373, 9389.76525586852, 9496.43021418717, 12788.657190994998, 12831.743365132832, 12842.486300547873, 12856.935715321551, 12891.806622900664, 6758.459323254128, 6818.897716534256, 6916.0, 6936.653167341613, 6954.65226738661, 6366.36336366369, 6444.226692796894, 6455.386738259858, 6605.207375114921, 6636.966815165893, 5696.316442026983, 5822.854428639318, 5932.673702946379, 5996.991008012365, 6145.723442445101, 1765.1174412793603, 1799.668245498348, 1803.3327668762379, 1803.9729404058949, 1812.0667856054142, 849.4648371525899, 860.2816648098908, 950.3632566180676, 958.8465845464832, 1010.9747256318503, 16548.0, 17629.55926101832, 17630.501407380518, 17911.373101941368, 17997.550061248574, 838.714836955438, 846.6740304982626, 873.5457562067817, 895.1540793949786, 940.5908429833045, 9397.436153830791, 10063.295569310225, 10089.899101009043, 10165.847512287322, 10172.338797978107, 376878.0, 379967.0, 384564.0, 385700.0, 401593.0, 67314.32685673179, 68316.0, 69424.6528767363, 70648.64675676588, 71360.64319678368, 909.5134103254859, 922.1792604581927, 943.2689665509148, 949.8907625623003, 955.4840386191379, 15024.774628380364, 15164.24178791034, 15327.38690452414, 15582.766258506359, 15815.762763558785, 34870.47694284537, 35380.823095884356, 35459.290814183056, 35809.82095089508, 35921.46117808287, 50428.49571504238, 51248.48751512586, 53077.0, 54898.451015489336, 55085.173722393396, 7176.672315621627, 7224.2053374129855, 7367.189609143097, 7526.661300241392, 7647.655855486405, 8585.914140858511, 10819.513121909691, 10920.563177472812, 10930.45347732626, 11170.106391488498, 9742.75643108928, 10051.34666246721, 10106.444145572064, 10594.0, 10863.728406789893, 9082.591283392396, 9330.113639204264, 9384.108509691569, 9389.859152112587, 9424.481653508848, 9890.505474726378, 10111.597081535734, 10186.286959912735, 10332.173426126043, 10529.315594486334, 7303.963480182565, 7329.193788683134, 7361.705531778669, 7401.111866576045, 7487.138979017483, 10093.394396336244, 10468.267221294436, 10604.787904241717, 10756.784864302514, 10880.45597720095], "value": 8033.816804079313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.0566700476163, 1389.798479220513, 1438.4965262158246, 1622.7971503562055, 1647.2839247810102, 6718.46252299816, 7504.3996480281585, 7588.962055189723, 8064.4758090724135, 8098.554579498125, 7611.923880761191, 7876.330511906481, 7890.40821938354, 7891.329237014861, 7943.960280198591, 2118.163325486436, 2162.243214874797, 2164.0, 2165.5560610074895, 2170.2295685031822, 2143.506993391521, 2174.554216385637, 2200.020990659157, 2211.6903633491324, 2214.2803588833613, 2172.880491572963, 2187.114218741412, 2194.8353873459473, 2195.3084778294788, 2209.55808838233, 2127.351157896841, 2130.893455327235, 2138.112683236455, 2143.5391390850964, 2144.0887622760265, 2096.8846713430753, 2113.7780533044115, 2124.309599380192, 2127.095984206706, 2131.4564785979633, 7994.760157195294, 8039.115697273295, 8044.879326810103, 8060.476069055492, 8072.959635201845, 4295.312749960022, 4378.255696531565, 4444.35556844259, 4449.065696203801, 4452.998075433002, 2816.084772448962, 2847.658281006272, 2891.277180704824, 2902.3034471726633, 2938.2213713365977, 904.6517090919978, 948.0566835998226, 958.2046901072093, 965.3146266151041, 979.9951000244953, 10578.947105264502, 10676.839847402296, 10680.946595266974, 10701.732456688567, 10703.250772445932, 3890.980545097313, 3931.8820435386983, 4041.939370909439, 4151.8962025949595, 4174.144300418407, 9024.548772561346, 9169.633214671338, 9181.173694367539, 9208.12522810332, 9212.401193922507, 4390.363397307437, 4398.516163222043, 4401.6478681705385, 4417.315316126005, 4418.977905110518, 3517.384457719889, 3811.3901775715754, 3897.006263402814, 4043.91912161761, 4052.858149964796, 3623.2753449310244, 3640.872569460056, 3666.3400587894434, 3681.392570225936, 3750.868719594801, 1165.7027457998156, 1178.4461303187488, 1183.6271574454192, 1190.1609365397373, 1192.5587532612988, 678.3081257117713, 695.937365637085, 710.3393843725385, 819.6024927909959, 846.0989046665404, 4878.341423907727, 4921.360223170965, 5145.24643495097, 5151.5621172200035, 5297.682139071668, 409.61496193577943, 414.0828065834192, 416.90202802341423, 420.1198489165194, 424.39311784148964, 3422.6748458896864, 3429.1427143214196, 3444.2422667013216, 3550.5206797082064, 3566.9477504136344, 9240.168384845396, 9762.316637835425, 9790.363626364264, 9797.412155270707, 9803.656872009446, 9529.809403811885, 9540.3321767477, 9731.513424328756, 9833.557489912972, 9898.158656514277, 7384.040074790243, 7446.925530744732, 7447.069116360455, 7448.255174482617, 7483.326500614862, 4944.283078953604, 4964.851054468228, 5004.499550045112, 5031.572316353151, 5322.175062865262, 9076.364654474388, 9117.452952822852, 9151.359404841598, 9211.309151813506, 9251.306152038489, 8617.655293788179, 9034.954825225832, 9038.502882341534, 9136.08639136081, 9310.581023854078, 5811.651300921958, 6541.476681865534, 6720.529562930548, 6840.726370945106, 7037.824054398681, 7663.348615367533, 7774.533527988338, 7801.843963120819, 7814.257645523666, 7817.491863028885, 6849.931500684929, 6990.825229369103, 7013.403860671696, 7047.224805271314, 7136.536125151849, 6497.4477169441125, 6766.323367663194, 6779.050932869501, 6917.377436030782, 6956.0, 6015.879682406415, 6029.1559181715475, 6076.908846367396, 6077.270727512727, 6192.102145188832, 4361.149575832682, 4383.298672212431, 4409.845655402046, 4567.269236922077, 4591.77041147948, 4522.728636281834, 4590.311453282035, 4605.884852878705, 4704.435467743892, 4758.310045043519], "value": 4023.6059540723227, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.8520276854651, 286.34141474608396, 296.3716920129326, 297.7885701152182, 301.39269372215006, 4771.928421073687, 4830.782614782334, 4909.386326709161, 5025.366755804369, 5044.5207705267985, 4885.8534243972645, 4917.975410122954, 4943.406791185053, 4966.875828104299, 4968.577670897969, 3930.8034598270115, 3940.349842276021, 3951.4786807079195, 3959.524857017162, 3960.7425517341426, 3587.5336206293277, 3939.5075615548058, 3950.7209016516367, 3971.5432725236533, 3973.98013009936, 3753.831077601501, 3765.1008723283194, 3773.3019391412677, 3781.8865434037025, 3805.353089974697, 3774.4338349247696, 3777.9811100944594, 3778.2254637799183, 3794.1842503861803, 3815.4467602197524, 3310.635830058716, 3339.231976645361, 3339.933201335984, 3343.281194543185, 3350.2294472271515, 4740.170470167707, 4770.761461926924, 4788.664793464459, 4881.414230292387, 4887.511248875119, 4259.51015633203, 4266.997255644921, 4274.358846173068, 4286.185624731291, 4293.484781826201, 5082.475257422759, 5085.753990272407, 5086.79652813887, 5117.897642047175, 5124.743762811881, 3445.173158441981, 3559.857605695769, 3566.8394922228563, 3574.8391322390294, 3585.94621080684, 5312.229726689647, 5321.3348331458565, 5325.4940780625775, 5352.197170424429, 5378.596605254622, 3628.546431696038, 3630.6550877666577, 3632.7457078004813, 3660.5790334111916, 3662.688671462902, 3700.16746232101, 3736.065983504124, 3737.495877761906, 3742.681872040907, 3752.874137758716, 4167.517671849095, 4281.314989601711, 4294.828206871753, 4311.417958575615, 4328.285832837547, 5119.539241468211, 5130.410002849645, 5131.846044618667, 5133.871653208625, 5138.3577052868395, 1212.484694005062, 1249.6126200877757, 1277.6422601671547, 1286.395394164741, 1292.5652525696469, 841.9727931923044, 870.0733718589681, 882.8719835623799, 896.5562046786882, 898.3621628643606, 4548.408706868086, 4550.385697930803, 4556.589906908328, 4558.544145585415, 4560.635149188057, 5220.686758794409, 5261.76322065508, 5270.732146069461, 5272.6309158358545, 5288.233206185082, 4501.437320334958, 4519.54804519552, 4540.114677637895, 4541.818327266872, 4578.184416583844, 2672.559027760398, 2813.6213255505063, 2841.5169421198448, 2851.8574071296352, 2861.5850701648146, 5059.772310246048, 5089.592832573459, 5092.021167616912, 5104.9489505104475, 5128.512791284822, 5249.291345668286, 5411.485908838654, 5480.287562616834, 5480.287562616834, 5487.862803429946, 5072.873178170576, 5075.28945947575, 5075.441701412841, 5075.705695047739, 5092.770825312796, 5336.146216605324, 5349.709928394088, 5354.3842458117815, 5366.463353664759, 5370.462953704755, 5040.596752259884, 5204.799048585017, 5206.375234971828, 5216.947830521646, 5233.371995360581, 5077.7968881245815, 5096.159133742891, 5097.8725531862, 5106.923396148986, 5118.206677964921, 3633.6184700606054, 3654.8355324009954, 3695.796731179811, 3697.186618943828, 3697.4638677392168, 5184.0, 5253.23828044939, 5259.347416443427, 5367.758450869642, 5387.407385187548, 5150.742462876916, 5156.690598564098, 5157.252198431132, 5165.61257905651, 5189.636725429184, 5128.8717782054255, 5130.153524668537, 5136.8202112925865, 5150.098732721834, 5151.14558758854, 4829.927551086666, 5073.44192138857, 5097.643164978416, 5112.335396398445, 5144.408393034849, 5152.639315247897, 5182.24857395668, 5199.4540573239265, 5199.506046925536, 5243.528082472596, 5106.770195341144, 5119.308893299506, 5120.18077107661, 5125.7693403796175, 5127.794888204579], "value": 3870.460870676034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8816236752648, 601.2034054877288, 605.5488660947594, 610.2615834839844, 726.7238449389231, 12231.266124032552, 12706.555270565532, 13184.538541151062, 13195.934020329896, 13216.405261763231, 13935.860641393583, 14618.707625847503, 14692.779608305884, 14720.484783032596, 14781.408743650269, 754.6717178027549, 779.0612312163857, 779.8479296537178, 783.9529628222325, 784.2667106255641, 616.4852348289184, 746.0972223609411, 770.7456539342031, 776.8718161503346, 783.2872086401376, 807.5275963561323, 810.3152835853724, 812.9187081291853, 815.0260438775665, 815.8001289684006, 804.9879251811199, 807.4065561812092, 808.1756608259572, 809.4253080312985, 811.395510344791, 591.7514643849594, 594.6699581732137, 596.6241268001131, 597.2444857255575, 597.901346277868, 12269.631911042683, 12325.815112773316, 12364.072694547946, 12365.0, 12367.257964522158, 12951.740965180643, 13260.668483287898, 13431.798523022162, 13456.394462249222, 13696.178229306273, 10318.793624127475, 10636.30863993838, 10736.570537178504, 10836.0789332906, 10842.169433257077, 3211.96788032119, 3212.389645967282, 3214.9678503214905, 3244.707976282122, 3252.9837350813095, 53054.0, 55238.17142742862, 55624.44375556233, 61004.38995609987, 67233.0, 9508.857367139499, 9791.118799307955, 9891.802163956681, 9951.959848231096, 10248.897511024794, 18206.271749129886, 18464.446066618024, 18537.165827537792, 18669.813301867078, 18770.0, 6165.32181460039, 6536.803895883036, 6814.080099186546, 6903.792886213421, 7021.5787052777, 3673.1000904778502, 3683.8710645127826, 3740.6259374062374, 3789.4694742736037, 3801.2777572261184, 2837.3615936414553, 2953.896613618513, 2981.985090074536, 2984.4031193761334, 2988.1633142720075, 502.48495292325657, 502.8692539939569, 504.4148787406664, 505.7092172001114, 506.6200349737697, 592.1502643706295, 595.4164918379926, 609.4697613076563, 616.8797084568466, 624.2758400255682, 8090.110087890327, 8133.471324363897, 8413.915860841436, 8473.322134229247, 8701.564921753887, 485.0292894469097, 490.5903570518586, 616.0758861707438, 627.3569591169088, 630.4735545819292, 3880.9223815524097, 4031.395290706359, 4281.657467402601, 4339.153864996359, 4404.339349097597, 99673.50163249137, 101470.0, 102669.48665256627, 102770.48614756878, 107411.0, 73747.63126184334, 82875.0, 88473.0, 88739.0, 89270.0, 60693.39306606878, 67914.0, 68573.0, 69617.30382696108, 71302.0, 7754.457187997012, 8598.914010860062, 8700.434471759316, 8899.243564297107, 8996.820063598821, 40894.97762555841, 42636.0, 43389.566104338555, 43847.78076109599, 44007.77996109999, 63563.682181588796, 63592.0, 63677.681611591644, 63928.16431014154, 63933.680331599906, 10317.432541210306, 10938.289011214245, 11049.72375690582, 11152.832707509231, 11653.883461165618, 12858.807117893426, 13016.804747928978, 13093.738125237633, 13187.340632968506, 13824.930875345559, 10052.547635356574, 11762.176647634926, 11992.040636749214, 12754.87245127574, 12814.038947079192, 11702.4733886977, 11961.342126183143, 12330.445129969352, 12334.0, 12390.752184956431, 10703.839442408214, 10839.620613278497, 11243.4378281084, 11296.209265351346, 11370.260933039657, 9283.798470481554, 9408.0, 9519.190868775955, 9523.904760952302, 9799.268071358181, 8952.776180595538, 9286.767830804283, 9329.440233586007, 9751.268654850772, 10331.535080921527], "value": 6526.705153535722, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1632.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 112.0, 117.0, 115.0, 116.0, 125.0, 115.0, 116.0, 119.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 124.0, 159.0, 185.0, 127.0, 156.0, 156.0, 144.0, 189.0, 128.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 164.0, 166.0, 167.0, 168.0, 167.0, 169.0, 163.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 172.0, 79.0, 82.0, 80.0, 76.0, 174.0, 79.0], "value": 97.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 147.0, 88.0, 89.0, 88.0, 133.0, 88.0, 90.0, 140.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 118.0, 119.0, 119.0, 130.0, 120.0, 121.0, 120.0, 119.0, 119.0], "value": 121.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 148.0, 147.0, 150.0, 148.0, 148.0, 150.0, 152.0, 149.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 111.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 72.0, 66.0, 65.0, 66.0, 65.0, 67.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 66.0, 70.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 84.0, 89.0, 85.0, 92.0, 88.0, 86.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 149.0, 142.0, 144.0, 138.0, 160.0, 148.0, 149.0, 169.0, 143.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 180.0, 176.0, 197.0, 175.0, 183.0, 175.0, 178.0, 180.0, 181.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 77.0, 73.0, 75.0, 74.0, 71.0, 71.0, 73.0], "value": 72.9, "unit": "score"}]}]} 12:36:00 INFO - Return code: 0 12:36:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:36:00 ERROR - # TBPL SUCCESS # 12:36:00 INFO - Running post-action listener: _resource_record_post_action 12:36:00 INFO - [mozharness: 2016-08-22 19:36:00.460639Z] Finished run-tests step (success) 12:36:00 INFO - Running post-run listener: _resource_record_post_run 12:36:00 INFO - Total resource usage - Wall time: 1203s; CPU: 14.0%; Read bytes: 4096; Write bytes: 408776704; Read time: 8; Write time: 1354468 12:36:00 INFO - TinderboxPrint: CPU usage
13.9% 12:36:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:36:00 INFO - TinderboxPrint: I/O write bytes / time
408,776,704 / 1,354,468 12:36:00 INFO - TinderboxPrint: CPU idle
8,254.2 (86.0%) 12:36:00 INFO - TinderboxPrint: CPU user
1,231.8 (12.8%) 12:36:00 INFO - TinderboxPrint: Swap in / out
0 / 0 12:36:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118374400; Read time: 0; Write time: 304360 12:36:00 INFO - run-tests - Wall time: 1188s; CPU: 14.0%; Read bytes: 0; Write bytes: 290402304; Read time: 0; Write time: 1050108 12:36:01 INFO - Running post-run listener: _upload_blobber_files 12:36:01 INFO - Blob upload gear active. 12:36:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:36:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:36:01 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:36:01 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:36:01 INFO - (blobuploader) - INFO - Open directory for files ... 12:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:11 INFO - (blobuploader) - INFO - Done attempting. 12:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:12 INFO - (blobuploader) - INFO - Done attempting. 12:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:13 INFO - (blobuploader) - INFO - Done attempting. 12:36:13 INFO - (blobuploader) - INFO - Iteration through files over. 12:36:13 INFO - Return code: 0 12:36:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:36:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:36:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7cdbbb727c349ee81e930ce12be6f8184645507e9686e16ba03751aa8e496366023928ea1167f802ea523c18f2a1e465c0572b32f9b52a0ece650f2181d1a050", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/022b60aa3b3ca12ef9c641d25f4885361718afbc3bbca2df07d9cc605091f6147867e95d37a714e1762f3b9943edc5158f3dea626fcc952d0684fc4556988702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b76617937cc7ce971cfb8472bc09003280e53aa7c6f1a7b2097884b3ca63bda3235bec4b83fa0f50894934c44d1f2d8491e5d002d928d75eedaf3d8f44e0298a"} 12:36:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:36:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:36:13 INFO - Contents: 12:36:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7cdbbb727c349ee81e930ce12be6f8184645507e9686e16ba03751aa8e496366023928ea1167f802ea523c18f2a1e465c0572b32f9b52a0ece650f2181d1a050", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/022b60aa3b3ca12ef9c641d25f4885361718afbc3bbca2df07d9cc605091f6147867e95d37a714e1762f3b9943edc5158f3dea626fcc952d0684fc4556988702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b76617937cc7ce971cfb8472bc09003280e53aa7c6f1a7b2097884b3ca63bda3235bec4b83fa0f50894934c44d1f2d8491e5d002d928d75eedaf3d8f44e0298a"} 12:36:13 INFO - Running post-run listener: copy_logs_to_upload_dir 12:36:13 INFO - Copying logs to upload dir... 12:36:13 INFO - mkdir: /builds/slave/test/build/upload/logs 12:36:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.454162 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-08-22 12:36:13.287910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 12:36:13.292538) ========= 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=df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7cdbbb727c349ee81e930ce12be6f8184645507e9686e16ba03751aa8e496366023928ea1167f802ea523c18f2a1e465c0572b32f9b52a0ece650f2181d1a050", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/022b60aa3b3ca12ef9c641d25f4885361718afbc3bbca2df07d9cc605091f6147867e95d37a714e1762f3b9943edc5158f3dea626fcc952d0684fc4556988702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b76617937cc7ce971cfb8472bc09003280e53aa7c6f1a7b2097884b3ca63bda3235bec4b83fa0f50894934c44d1f2d8491e5d002d928d75eedaf3d8f44e0298a"} build_url:https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/O396p1JlQLSgKBa27-2zng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7cdbbb727c349ee81e930ce12be6f8184645507e9686e16ba03751aa8e496366023928ea1167f802ea523c18f2a1e465c0572b32f9b52a0ece650f2181d1a050", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/022b60aa3b3ca12ef9c641d25f4885361718afbc3bbca2df07d9cc605091f6147867e95d37a714e1762f3b9943edc5158f3dea626fcc952d0684fc4556988702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b76617937cc7ce971cfb8472bc09003280e53aa7c6f1a7b2097884b3ca63bda3235bec4b83fa0f50894934c44d1f2d8491e5d002d928d75eedaf3d8f44e0298a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 12:36:13.318636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:36:13.319038) ========= 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=df17445c3590ff7897617a0e00000225-1471893317.925583-1016280040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:36:13.403643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 12:36:13.404053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 12:36:13.404406) ========= ========= Total master_lag: 0.18 =========