builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1476279358.77 results: success (0) buildid: 20161012051247 builduid: 8eefdbdd4b2043f0ad22a091a8ccd2a3 revision: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.775241) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.775660) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.775944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.846200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.846568) ========= 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=41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 06:35:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 128M=0s 2016-10-12 06:35:59 (128 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.938558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.938837) ========= 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=41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018115 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.988507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.988807) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 --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=41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 06:35:59,626 truncating revision to first 12 chars 2016-10-12 06:35:59,626 Setting DEBUG logging. 2016-10-12 06:35:59,626 attempt 1/10 2016-10-12 06:35:59,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/4756eb1a2f82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 06:36:00,009 unpacking tar archive at: larch-4756eb1a2f82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.709810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.710102) ========= script_repo_revision: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.710502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.710766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.720082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-12 06:35:59.720364) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-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=41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:36:00 INFO - MultiFileLogger online at 20161012 06:36:00 in /builds/slave/test 06:36:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 06:36:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:00 INFO - {'append_to_log': False, 06:36:00 INFO - 'base_work_dir': '/builds/slave/test', 06:36:00 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 06:36:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:00 INFO - 'branch': 'Larch-Non-PGO', 06:36:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:00 INFO - 'config_files': ('talos/linux_config.py',), 06:36:00 INFO - 'default_actions': ('clobber', 06:36:00 INFO - 'read-buildbot-config', 06:36:00 INFO - 'download-and-extract', 06:36:00 INFO - 'populate-webroot', 06:36:00 INFO - 'create-virtualenv', 06:36:00 INFO - 'install', 06:36:00 INFO - 'run-tests'), 06:36:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:00 INFO - 'download_minidump_stackwalk': True, 06:36:00 INFO - 'download_symbols': 'ondemand', 06:36:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:00 INFO - 'installer_path': 'installer.exe', 06:36:00 INFO - 'log_level': 'info', 06:36:00 INFO - 'log_name': 'talos', 06:36:00 INFO - 'log_to_console': True, 06:36:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:36:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:36:00 INFO - 'opt_config_files': (), 06:36:00 INFO - 'pip_index': False, 06:36:00 INFO - 'sps_profile': False, 06:36:00 INFO - 'sps_profile_interval': 0, 06:36:00 INFO - 'suite': 'dromaeojs-e10s', 06:36:00 INFO - 'system_bits': '32', 06:36:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:00 INFO - 'title': 'talos-linux64-ix-026', 06:36:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:00 INFO - 'use_talos_json': True, 06:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:00 INFO - 'work_dir': 'build'} 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.457651Z] Running clobber step. 06:36:00 INFO - Running pre-action listener: _resource_record_pre_action 06:36:00 INFO - Running main action method: clobber 06:36:00 INFO - rmtree: /builds/slave/test/build 06:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:00 INFO - Running post-action listener: _resource_record_post_action 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.916494Z] Finished clobber step (success) 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.916594Z] Running read-buildbot-config step. 06:36:00 INFO - Running pre-action listener: _resource_record_pre_action 06:36:00 INFO - Running main action method: read_buildbot_config 06:36:00 INFO - Using buildbot properties: 06:36:00 INFO - { 06:36:00 INFO - "project": "", 06:36:00 INFO - "product": "firefox", 06:36:00 INFO - "script_repo_revision": "production", 06:36:00 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 06:36:00 INFO - "repository": "", 06:36:00 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 06:36:00 INFO - "buildid": "20161012051247", 06:36:00 INFO - "pgo_build": "False", 06:36:00 INFO - "basedir": "/builds/slave/test", 06:36:00 INFO - "buildnumber": 4, 06:36:00 INFO - "slavename": "talos-linux64-ix-026", 06:36:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:36:00 INFO - "platform": "ubuntu64_hw", 06:36:00 INFO - "scheduler": "tests-larch-linux64-talos", 06:36:00 INFO - "branch": "larch", 06:36:00 INFO - "repo_path": "projects/larch", 06:36:00 INFO - "revision": "4756eb1a2f82a6fb2e7ab5e3708d14aa76816076", 06:36:00 INFO - "stage_platform": "linux64", 06:36:00 INFO - "builduid": "8eefdbdd4b2043f0ad22a091a8ccd2a3", 06:36:00 INFO - "slavebuilddir": "test" 06:36:00 INFO - } 06:36:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:36:00 INFO - Running post-action listener: _resource_record_post_action 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.919013Z] Finished read-buildbot-config step (success) 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.919100Z] Running download-and-extract step. 06:36:00 INFO - Running pre-action listener: _resource_record_pre_action 06:36:00 INFO - Running main action method: download_and_extract 06:36:00 INFO - mkdir: /builds/slave/test/build/tests 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:00 INFO - trying https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:36:01 INFO - Downloaded 1361 bytes. 06:36:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:01 INFO - Using the following test package requirements: 06:36:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:36:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:36:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'jsshell-linux-x86_64.zip'], 06:36:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:36:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:36:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:36:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:36:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:36:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:36:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:01 INFO - Fetch https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:36:02 INFO - Http code: 200 06:36:02 INFO - via: 1.1 f46e4d7bc5419470a70eb57aa9c935c8.cloudfront.net (CloudFront) 06:36:02 INFO - x-amz-cf-id: YIs2vUVt5ACNowspVIsB778403Im6Scw1kC6EZ39I7Ah_I4uLjP_Xg== 06:36:02 INFO - x-amz-version-id: mvkBAAMF2Pa_wBNlJuBi40QSPJQeBfnz 06:36:02 INFO - Expected file size: 20528584 06:36:02 INFO - Obtained file size: 20528584 06:36:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:36:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:06 INFO - Fetch https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:36:06 INFO - Http code: 200 06:36:06 INFO - via: 1.1 7db492e48a5d55351dcb787a8a14e113.cloudfront.net (CloudFront) 06:36:06 INFO - x-amz-cf-id: 229yAH0gKBFVhQHMigCrAU9ddtWKpnI39uZ1kOFTzuGS_d0GF4hMdg== 06:36:06 INFO - x-amz-version-id: mvkBAAMF2Pa_wBNlJuBi40QSPJQeBfnz 06:36:07 INFO - Expected file size: 20528584 06:36:07 INFO - Obtained file size: 20528584 06:36:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:36:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:36:11 INFO - Fetch https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:36:12 INFO - Http code: 200 06:36:12 INFO - via: 1.1 f46e4d7bc5419470a70eb57aa9c935c8.cloudfront.net (CloudFront) 06:36:12 INFO - x-amz-cf-id: ygUE5Sdw-5Rx0TvxDeZWGgpgiJpZKNuTeeW3znd0z2-GeGKttKgdfA== 06:36:12 INFO - x-amz-version-id: VwLmDL9HMrV_jQjvgp1awave.RHqZB42 06:36:12 INFO - Expected file size: 14409006 06:36:12 INFO - Obtained file size: 14409006 06:36: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')]} 06:36:12 INFO - trying https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:36:14 INFO - Downloaded 56011968 bytes. 06:36:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:14 INFO - mkdir: /builds/slave/test/properties 06:36:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:14 INFO - Contents: 06:36:14 INFO - build_url:https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:15 INFO - Running post-action listener: _resource_record_post_action 06:36:15 INFO - Running post-action listener: set_extra_try_arguments 06:36:15 INFO - [mozharness: 2016-10-12 13:36:15.014034Z] Finished download-and-extract step (success) 06:36:15 INFO - [mozharness: 2016-10-12 13:36:15.014295Z] Running populate-webroot step. 06:36:15 INFO - Running pre-action listener: _resource_record_pre_action 06:36:15 INFO - Running main action method: populate_webroot 06:36:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:15 INFO - '--tppagecycles', 06:36:15 INFO - '7'], 06:36:15 INFO - 'tests': ['tsvgm']}}, 06:36:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['damp', 'tps']}, 06:36:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'tests': ['damp', 'tps']}, 06:36:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['dromaeo_dom']}, 06:36:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['basic_compositor_video']}, 06:36:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:36:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['a11yr', 06:36:15 INFO - 'ts_paint', 06:36:15 INFO - 'tpaint', 06:36:15 INFO - 'sessionrestore', 06:36:15 INFO - 'sessionrestore_no_auto_restore', 06:36:15 INFO - 'tabpaint']}, 06:36:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:15 INFO - 'ts_paint', 06:36:15 INFO - 'tpaint', 06:36:15 INFO - 'sessionrestore', 06:36:15 INFO - 'sessionrestore_no_auto_restore', 06:36:15 INFO - 'tabpaint']}, 06:36:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:15 INFO - 'ts_paint', 06:36:15 INFO - 'tpaint', 06:36:15 INFO - 'sessionrestore', 06:36:15 INFO - 'sessionrestore_no_auto_restore', 06:36:15 INFO - 'tabpaint']}, 06:36:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:15 INFO - 'ts_paint', 06:36:15 INFO - 'tpaint', 06:36:15 INFO - 'sessionrestore', 06:36:15 INFO - 'sessionrestore_no_auto_restore', 06:36:15 INFO - 'tabpaint']}, 06:36:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['a11yr', 06:36:15 INFO - 'ts_paint', 06:36:15 INFO - 'tpaint', 06:36:15 INFO - 'sessionrestore', 06:36:15 INFO - 'sessionrestore_no_auto_restore', 06:36:15 INFO - 'tabpaint']}, 06:36:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['a11yr', 06:36:15 INFO - 'ts_paint', 06:36:15 INFO - 'tpaint', 06:36:15 INFO - 'sessionrestore', 06:36:15 INFO - 'sessionrestore_no_auto_restore', 06:36:15 INFO - 'tabpaint']}, 06:36:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['tsvgx', 06:36:15 INFO - 'tsvgr_opacity', 06:36:15 INFO - 'tart', 06:36:15 INFO - 'tscrollx', 06:36:15 INFO - 'cart']}, 06:36:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:15 INFO - 'tsvgr_opacity', 06:36:15 INFO - 'tart', 06:36:15 INFO - 'tscrollx', 06:36:15 INFO - 'cart']}, 06:36:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'talos_options': ['--disable-e10s'], 06:36:15 INFO - 'tests': ['tp5o']}, 06:36:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'tests': ['tp5o']}, 06:36:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'talos_options': ['--disable-e10s', 06:36:15 INFO - '--xperf_path', 06:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:15 INFO - 'tests': ['tp5n']}, 06:36:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:15 INFO - 'talos_options': ['--xperf_path', 06:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:15 INFO - 'tests': ['tp5n']}}, 06:36:15 INFO - 'talos.zip': {'path': '', 06:36:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:15 INFO - Running post-action listener: _resource_record_post_action 06:36:15 INFO - [mozharness: 2016-10-12 13:36:15.032598Z] Finished populate-webroot step (success) 06:36:15 INFO - [mozharness: 2016-10-12 13:36:15.032685Z] Running create-virtualenv step. 06:36:15 INFO - Running pre-action listener: _resource_record_pre_action 06:36:15 INFO - Running main action method: create_virtualenv 06:36:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:36:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:15 INFO - Using real prefix '/usr' 06:36:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:17 INFO - Installing pip.................done. 06:36:17 INFO - Return code: 0 06:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:36:17 INFO - Reading from file tmpfile_stdout 06:36:17 INFO - Output received: 06:36:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:36:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:36:17 INFO - Using env: {'DISPLAY': ':0', 06:36:17 INFO - 'HOME': '/home/cltbld', 06:36:17 INFO - 'LANG': 'en_US.UTF-8', 06:36:17 INFO - 'LANGUAGE': 'en_US:en', 06:36:17 INFO - 'LOGNAME': 'cltbld', 06:36:17 INFO - 'MAIL': '/var/mail/cltbld', 06:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:17 INFO - 'MOZ_NO_REMOTE': '1', 06:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:17 INFO - 'NO_EM_RESTART': '1', 06:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:17 INFO - 'PWD': '/builds/slave/test', 06:36:17 INFO - 'SHELL': '/bin/bash', 06:36:17 INFO - 'SHLVL': '1', 06:36:17 INFO - 'TERM': 'linux', 06:36:17 INFO - 'TMOUT': '86400', 06:36:17 INFO - 'USER': 'cltbld', 06:36:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:17 INFO - '_': '/tools/buildbot/bin/python'} 06:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:36:18 INFO - Cleaning up... 06:36:18 INFO - Return code: 0 06:36:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:36:18 INFO - Using env: {'DISPLAY': ':0', 06:36:18 INFO - 'HOME': '/home/cltbld', 06:36:18 INFO - 'LANG': 'en_US.UTF-8', 06:36:18 INFO - 'LANGUAGE': 'en_US:en', 06:36:18 INFO - 'LOGNAME': 'cltbld', 06:36:18 INFO - 'MAIL': '/var/mail/cltbld', 06:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:18 INFO - 'MOZ_NO_REMOTE': '1', 06:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:18 INFO - 'NO_EM_RESTART': '1', 06:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:18 INFO - 'PWD': '/builds/slave/test', 06:36:18 INFO - 'SHELL': '/bin/bash', 06:36:18 INFO - 'SHLVL': '1', 06:36:18 INFO - 'TERM': 'linux', 06:36:18 INFO - 'TMOUT': '86400', 06:36:18 INFO - 'USER': 'cltbld', 06:36:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:18 INFO - '_': '/tools/buildbot/bin/python'} 06:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:18 INFO - Downloading/unpacking psutil>=3.1.1 06:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:20 INFO - Installing collected packages: psutil 06:36:20 INFO - Running setup.py install for psutil 06:36:20 INFO - building 'psutil._psutil_linux' extension 06:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:36:20 INFO - building 'psutil._psutil_posix' extension 06:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:20 INFO - Successfully installed psutil 06:36:20 INFO - Cleaning up... 06:36:20 INFO - Return code: 0 06:36:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:20 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:36:20 INFO - Using env: {'DISPLAY': ':0', 06:36:20 INFO - 'HOME': '/home/cltbld', 06:36:20 INFO - 'LANG': 'en_US.UTF-8', 06:36:20 INFO - 'LANGUAGE': 'en_US:en', 06:36:20 INFO - 'LOGNAME': 'cltbld', 06:36:20 INFO - 'MAIL': '/var/mail/cltbld', 06:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:20 INFO - 'MOZ_NO_REMOTE': '1', 06:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:20 INFO - 'NO_EM_RESTART': '1', 06:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:20 INFO - 'PWD': '/builds/slave/test', 06:36:20 INFO - 'SHELL': '/bin/bash', 06:36:20 INFO - 'SHLVL': '1', 06:36:20 INFO - 'TERM': 'linux', 06:36:20 INFO - 'TMOUT': '86400', 06:36:20 INFO - 'USER': 'cltbld', 06:36:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:20 INFO - '_': '/tools/buildbot/bin/python'} 06:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:36:23 INFO - Installing collected packages: mozsystemmonitor 06:36:23 INFO - Running setup.py install for mozsystemmonitor 06:36:23 INFO - Successfully installed mozsystemmonitor 06:36:23 INFO - Cleaning up... 06:36:23 INFO - Return code: 0 06:36:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:36:23 INFO - Using env: {'DISPLAY': ':0', 06:36:23 INFO - 'HOME': '/home/cltbld', 06:36:23 INFO - 'LANG': 'en_US.UTF-8', 06:36:23 INFO - 'LANGUAGE': 'en_US:en', 06:36:23 INFO - 'LOGNAME': 'cltbld', 06:36:23 INFO - 'MAIL': '/var/mail/cltbld', 06:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:23 INFO - 'MOZ_NO_REMOTE': '1', 06:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:23 INFO - 'NO_EM_RESTART': '1', 06:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:23 INFO - 'PWD': '/builds/slave/test', 06:36:23 INFO - 'SHELL': '/bin/bash', 06:36:23 INFO - 'SHLVL': '1', 06:36:23 INFO - 'TERM': 'linux', 06:36:23 INFO - 'TMOUT': '86400', 06:36:23 INFO - 'USER': 'cltbld', 06:36:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:23 INFO - '_': '/tools/buildbot/bin/python'} 06:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:23 INFO - Downloading/unpacking jsonschema==2.5.1 06:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:25 INFO - warning: no files found matching '*.txt' 06:36:25 INFO - no previously-included directories found matching 'build' 06:36:25 INFO - no previously-included directories found matching 'dist' 06:36:25 INFO - no previously-included directories found matching '.git*' 06:36:25 INFO - Installing collected packages: jsonschema, functools32 06:36:25 INFO - Running setup.py install for functools32 06:36:25 INFO - warning: no files found matching '*.txt' 06:36:25 INFO - no previously-included directories found matching 'build' 06:36:25 INFO - no previously-included directories found matching 'dist' 06:36:25 INFO - no previously-included directories found matching '.git*' 06:36:25 INFO - Successfully installed jsonschema functools32 06:36:25 INFO - Cleaning up... 06:36:25 INFO - Return code: 0 06:36:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:36:25 INFO - Using env: {'DISPLAY': ':0', 06:36:25 INFO - 'HOME': '/home/cltbld', 06:36:25 INFO - 'LANG': 'en_US.UTF-8', 06:36:25 INFO - 'LANGUAGE': 'en_US:en', 06:36:25 INFO - 'LOGNAME': 'cltbld', 06:36:25 INFO - 'MAIL': '/var/mail/cltbld', 06:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:25 INFO - 'MOZ_NO_REMOTE': '1', 06:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:25 INFO - 'NO_EM_RESTART': '1', 06:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:25 INFO - 'PWD': '/builds/slave/test', 06:36:25 INFO - 'SHELL': '/bin/bash', 06:36:25 INFO - 'SHLVL': '1', 06:36:25 INFO - 'TERM': 'linux', 06:36:25 INFO - 'TMOUT': '86400', 06:36:25 INFO - 'USER': 'cltbld', 06:36:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:25 INFO - '_': '/tools/buildbot/bin/python'} 06:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:36:25 INFO - Cleaning up... 06:36:25 INFO - Return code: 0 06:36:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:36:25 INFO - Using env: {'DISPLAY': ':0', 06:36:25 INFO - 'HOME': '/home/cltbld', 06:36:25 INFO - 'LANG': 'en_US.UTF-8', 06:36:25 INFO - 'LANGUAGE': 'en_US:en', 06:36:25 INFO - 'LOGNAME': 'cltbld', 06:36:25 INFO - 'MAIL': '/var/mail/cltbld', 06:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:25 INFO - 'MOZ_NO_REMOTE': '1', 06:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:25 INFO - 'NO_EM_RESTART': '1', 06:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:25 INFO - 'PWD': '/builds/slave/test', 06:36:25 INFO - 'SHELL': '/bin/bash', 06:36:25 INFO - 'SHLVL': '1', 06:36:25 INFO - 'TERM': 'linux', 06:36:25 INFO - 'TMOUT': '86400', 06:36:25 INFO - 'USER': 'cltbld', 06:36:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:25 INFO - '_': '/tools/buildbot/bin/python'} 06:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:26 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:28 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:28 INFO - Downloading docopt-0.6.1.tar.gz 06:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:28 INFO - Running setup.py install for blobuploader 06:36:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:28 INFO - Running setup.py install for requests 06:36:29 INFO - Running setup.py install for docopt 06:36:29 INFO - Successfully installed blobuploader requests docopt 06:36:29 INFO - Cleaning up... 06:36:29 INFO - Return code: 0 06:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:29 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:36:29 INFO - Using env: {'DISPLAY': ':0', 06:36:29 INFO - 'HOME': '/home/cltbld', 06:36:29 INFO - 'LANG': 'en_US.UTF-8', 06:36:29 INFO - 'LANGUAGE': 'en_US:en', 06:36:29 INFO - 'LOGNAME': 'cltbld', 06:36:29 INFO - 'MAIL': '/var/mail/cltbld', 06:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:29 INFO - 'MOZ_NO_REMOTE': '1', 06:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:29 INFO - 'NO_EM_RESTART': '1', 06:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:29 INFO - 'PWD': '/builds/slave/test', 06:36:29 INFO - 'SHELL': '/bin/bash', 06:36:29 INFO - 'SHLVL': '1', 06:36:29 INFO - 'TERM': 'linux', 06:36:29 INFO - 'TMOUT': '86400', 06:36:29 INFO - 'USER': 'cltbld', 06:36:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:29 INFO - '_': '/tools/buildbot/bin/python'} 06:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:29 INFO - Running setup.py (path:/tmp/pip-6OTra4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:29 INFO - Running setup.py (path:/tmp/pip-FDI6UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:29 INFO - Running setup.py (path:/tmp/pip-MkdCtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:29 INFO - Running setup.py (path:/tmp/pip-oJ8wwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:30 INFO - Running setup.py (path:/tmp/pip-hG6nt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:30 INFO - Running setup.py (path:/tmp/pip-rE9W05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:30 INFO - Running setup.py (path:/tmp/pip-8cT31y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:30 INFO - Running setup.py (path:/tmp/pip-EHJDW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:30 INFO - Running setup.py (path:/tmp/pip-kIVDWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:30 INFO - Running setup.py (path:/tmp/pip-_agbCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:30 INFO - Running setup.py (path:/tmp/pip-FvBUSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:30 INFO - Running setup.py (path:/tmp/pip-WUi29W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:30 INFO - Running setup.py (path:/tmp/pip-kEyCfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:30 INFO - Running setup.py (path:/tmp/pip-M_EOBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:30 INFO - Running setup.py (path:/tmp/pip-d3Drqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:30 INFO - Running setup.py (path:/tmp/pip-9Al_dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:30 INFO - Running setup.py (path:/tmp/pip-ttXs60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:30 INFO - Running setup.py install for manifestparser 06:36:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozcrash 06:36:31 INFO - Running setup.py install for mozdebug 06:36:31 INFO - Running setup.py install for mozdevice 06:36:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozfile 06:36:31 INFO - Running setup.py install for mozhttpd 06:36:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozinfo 06:36:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozInstall 06:36:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozleak 06:36:31 INFO - Running setup.py install for mozlog 06:36:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for moznetwork 06:36:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Running setup.py install for mozprocess 06:36:32 INFO - Running setup.py install for mozprofile 06:36:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Running setup.py install for mozrunner 06:36:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Running setup.py install for mozscreenshot 06:36:32 INFO - Running setup.py install for moztest 06:36:32 INFO - Running setup.py install for mozversion 06:36:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:32 INFO - Cleaning up... 06:36:32 INFO - Return code: 0 06:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:32 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:36:32 INFO - Using env: {'DISPLAY': ':0', 06:36:32 INFO - 'HOME': '/home/cltbld', 06:36:32 INFO - 'LANG': 'en_US.UTF-8', 06:36:32 INFO - 'LANGUAGE': 'en_US:en', 06:36:32 INFO - 'LOGNAME': 'cltbld', 06:36:32 INFO - 'MAIL': '/var/mail/cltbld', 06:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:32 INFO - 'MOZ_NO_REMOTE': '1', 06:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:32 INFO - 'NO_EM_RESTART': '1', 06:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:32 INFO - 'PWD': '/builds/slave/test', 06:36:32 INFO - 'SHELL': '/bin/bash', 06:36:32 INFO - 'SHLVL': '1', 06:36:32 INFO - 'TERM': 'linux', 06:36:32 INFO - 'TMOUT': '86400', 06:36:32 INFO - 'USER': 'cltbld', 06:36:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:32 INFO - '_': '/tools/buildbot/bin/python'} 06:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:32 INFO - Running setup.py (path:/tmp/pip-n5t7TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:33 INFO - Running setup.py (path:/tmp/pip-nOiBew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:33 INFO - Running setup.py (path:/tmp/pip-nwqxpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:33 INFO - Running setup.py (path:/tmp/pip-l8JQw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:33 INFO - Running setup.py (path:/tmp/pip-1PneMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:33 INFO - Running setup.py (path:/tmp/pip-uQIE4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:33 INFO - Running setup.py (path:/tmp/pip-UiiEBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:33 INFO - Running setup.py (path:/tmp/pip-0DzJeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:33 INFO - Running setup.py (path:/tmp/pip-TOMuVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:33 INFO - Running setup.py (path:/tmp/pip-cmDP8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:33 INFO - Running setup.py (path:/tmp/pip-9kjBNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:33 INFO - Running setup.py (path:/tmp/pip-9_v_pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:33 INFO - Running setup.py (path:/tmp/pip-I7MX7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:33 INFO - Running setup.py (path:/tmp/pip-YG0oLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:33 INFO - Running setup.py (path:/tmp/pip-V2UvMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:34 INFO - Running setup.py (path:/tmp/pip-6FrH1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:34 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)) 06:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:34 INFO - Running setup.py (path:/tmp/pip-81ATUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:36:34 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)) 06:36:34 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)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:36:34 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)) 06:36:34 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)) 06:36:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:36 INFO - Downloading blessings-1.6.tar.gz 06:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:36 INFO - Installing collected packages: blessings 06:36:36 INFO - Running setup.py install for blessings 06:36:36 INFO - Successfully installed blessings 06:36:36 INFO - Cleaning up... 06:36:36 INFO - Return code: 0 06:36:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:36 INFO - Reading from file tmpfile_stdout 06:36:36 INFO - Current package versions: 06:36:36 INFO - argparse == 1.2.1 06:36:36 INFO - blessings == 1.6 06:36:36 INFO - blobuploader == 1.2.4 06:36:36 INFO - docopt == 0.6.1 06:36:36 INFO - functools32 == 3.2.3-2 06:36:36 INFO - jsonschema == 2.5.1 06:36:36 INFO - manifestparser == 1.1 06:36:36 INFO - mozInstall == 1.12 06:36:36 INFO - mozcrash == 0.17 06:36:36 INFO - mozdebug == 0.1 06:36:36 INFO - mozdevice == 0.48 06:36:36 INFO - mozfile == 1.2 06:36:36 INFO - mozhttpd == 0.7 06:36:36 INFO - mozinfo == 0.9 06:36:36 INFO - mozleak == 0.1 06:36:36 INFO - mozlog == 3.4 06:36:36 INFO - moznetwork == 0.27 06:36:36 INFO - mozprocess == 0.23 06:36:36 INFO - mozprofile == 0.28 06:36:36 INFO - mozrunner == 6.12 06:36:36 INFO - mozscreenshot == 0.1 06:36:36 INFO - mozsystemmonitor == 0.3 06:36:36 INFO - moztest == 0.7 06:36:36 INFO - mozversion == 1.4 06:36:36 INFO - psutil == 3.1.1 06:36:36 INFO - requests == 1.2.3 06:36:36 INFO - wsgiref == 0.1.2 06:36:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:36:36 INFO - Using env: {'DISPLAY': ':0', 06:36:36 INFO - 'HOME': '/home/cltbld', 06:36:36 INFO - 'LANG': 'en_US.UTF-8', 06:36:36 INFO - 'LANGUAGE': 'en_US:en', 06:36:36 INFO - 'LOGNAME': 'cltbld', 06:36:36 INFO - 'MAIL': '/var/mail/cltbld', 06:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:36 INFO - 'MOZ_NO_REMOTE': '1', 06:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:36 INFO - 'NO_EM_RESTART': '1', 06:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:36 INFO - 'PWD': '/builds/slave/test', 06:36:36 INFO - 'SHELL': '/bin/bash', 06:36:36 INFO - 'SHLVL': '1', 06:36:36 INFO - 'TERM': 'linux', 06:36:36 INFO - 'TMOUT': '86400', 06:36:36 INFO - 'USER': 'cltbld', 06:36:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:36 INFO - '_': '/tools/buildbot/bin/python'} 06:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:36:36 INFO - Cleaning up... 06:36:36 INFO - Return code: 0 06:36:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 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 0x7f30dfddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, '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': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:36:36 INFO - Using env: {'DISPLAY': ':0', 06:36:36 INFO - 'HOME': '/home/cltbld', 06:36:36 INFO - 'LANG': 'en_US.UTF-8', 06:36:36 INFO - 'LANGUAGE': 'en_US:en', 06:36:36 INFO - 'LOGNAME': 'cltbld', 06:36:36 INFO - 'MAIL': '/var/mail/cltbld', 06:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:36 INFO - 'MOZ_NO_REMOTE': '1', 06:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:36 INFO - 'NO_EM_RESTART': '1', 06:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:36 INFO - 'PWD': '/builds/slave/test', 06:36:36 INFO - 'SHELL': '/bin/bash', 06:36:36 INFO - 'SHLVL': '1', 06:36:36 INFO - 'TERM': 'linux', 06:36:36 INFO - 'TMOUT': '86400', 06:36:36 INFO - 'USER': 'cltbld', 06:36:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:36 INFO - '_': '/tools/buildbot/bin/python'} 06:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:36:37 INFO - Cleaning up... 06:36:37 INFO - Return code: 0 06:36:37 INFO - Running post-action listener: _resource_record_post_action 06:36:37 INFO - Running post-action listener: _start_resource_monitoring 06:36:37 INFO - Starting resource monitoring. 06:36:37 INFO - [mozharness: 2016-10-12 13:36:37.076175Z] Finished create-virtualenv step (success) 06:36:37 INFO - [mozharness: 2016-10-12 13:36:37.076638Z] Running install step. 06:36:37 INFO - Running pre-action listener: _resource_record_pre_action 06:36:37 INFO - Running main action method: install 06:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:37 INFO - Reading from file tmpfile_stdout 06:36:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:37 INFO - Reading from file tmpfile_stdout 06:36:37 INFO - Output received: 06:36:37 INFO - Usage: mozinstall [options] installer 06:36:37 INFO - Options: 06:36:37 INFO - -h, --help show this help message and exit 06:36:37 INFO - -d DEST, --destination=DEST 06:36:37 INFO - Directory to install application into. [default: 06:36:37 INFO - "/builds/slave/test"] 06:36:37 INFO - --app=APP Application being installed. [default: firefox] 06:36:37 INFO - mkdir: /builds/slave/test/build/application 06:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:36:53 INFO - Reading from file tmpfile_stdout 06:36:53 INFO - Output received: 06:36:53 INFO - /builds/slave/test/build/application/firefox/firefox 06:36:53 INFO - Running post-action listener: _resource_record_post_action 06:36:53 INFO - [mozharness: 2016-10-12 13:36:53.530992Z] Finished install step (success) 06:36:53 INFO - [mozharness: 2016-10-12 13:36:53.531236Z] Running run-tests step. 06:36:53 INFO - Running pre-action listener: _resource_record_pre_action 06:36:53 INFO - Running main action method: run_tests 06:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:53 INFO - Python 2.7.3 06:36:53 INFO - Return code: 0 06:36:53 INFO - grabbing minidump binary from tooltool 06:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:53 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 0x1572f60>, '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 0x1573d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15741d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:36:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:36:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:36:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:53 INFO - Return code: 0 06:36:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:36:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:36:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 06:36:53 INFO - Using env: {'DISPLAY': ':0', 06:36:53 INFO - 'HOME': '/home/cltbld', 06:36:53 INFO - 'LANG': 'en_US.UTF-8', 06:36:53 INFO - 'LANGUAGE': 'en_US:en', 06:36:53 INFO - 'LOGNAME': 'cltbld', 06:36:53 INFO - 'MAIL': '/var/mail/cltbld', 06:36:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:53 INFO - 'MOZ_NO_REMOTE': '1', 06:36:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:53 INFO - 'NO_EM_RESTART': '1', 06:36:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:53 INFO - 'PWD': '/builds/slave/test', 06:36:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:53 INFO - 'SHELL': '/bin/bash', 06:36:53 INFO - 'SHLVL': '1', 06:36:53 INFO - 'TERM': 'linux', 06:36:53 INFO - 'TMOUT': '86400', 06:36:53 INFO - 'USER': 'cltbld', 06:36:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914', 06:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:53 INFO - '_': '/tools/buildbot/bin/python'} 06:36:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:36:53 INFO - mozversion application_buildid: 20161012051247 06:36:53 INFO - mozversion application_changeset: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 06:36:53 INFO - mozversion application_display_name: Nightly 06:36:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:53 INFO - mozversion application_name: Firefox 06:36:53 INFO - mozversion application_remotingname: firefox 06:36:53 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 06:36:53 INFO - mozversion application_vendor: Mozilla 06:36:53 INFO - mozversion application_version: 52.0a1 06:36:53 INFO - mozversion platform_buildid: 20161012051247 06:36:53 INFO - mozversion platform_changeset: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 06:36:53 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 06:36:53 INFO - mozversion platform_version: 52.0a1 06:36:53 INFO - using testdate: 1476279413 06:36:53 INFO - actual date: 1476279413 06:36:53 INFO - starting webserver on 'localhost:52154' 06:36:53 INFO - SUITE-START | Running 2 tests 06:36:53 INFO - TEST-START | dromaeo_css 06:36:53 INFO - operating with platform_type : linux_ 06:36:53 INFO - Initialising browser for dromaeo_css test... 06:36:53 INFO - TEST-INFO | started process 5054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphKSb_h/profile http://localhost:52154/getInfo.html) 06:36:59 INFO - PROCESS | 5054 | __metrics Screen width/height:1600/1200 06:36:59 INFO - PROCESS | 5054 | colorDepth:24 06:36:59 INFO - PROCESS | 5054 | Browser inner width/height: 1024/697 06:36:59 INFO - PROCESS | 5054 | __metrics 06:36:59 ERROR - PROCESS | 5054 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:37:00 INFO - TEST-INFO | 5054: exit 0 06:37:00 INFO - Browser initialized. 06:37:00 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:00 INFO - TEST-INFO | started process 5177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphKSb_h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:12 INFO - PROCESS | 5177 | RSS: Main: 187904000 06:37:12 INFO - PROCESS | 5177 | 06:38:02 INFO - PROCESS | 5177 | 1476279482680 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] 06:40:15 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52154/tests/dromaeo/cssquery-ext.html) 06:40:17 INFO - PROCESS | 5177 | RSS: Main: 200630272 06:40:17 INFO - PROCESS | 5177 | 06:43:20 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-ext.html (next: http://localhost:52154/tests/dromaeo/cssquery-jquery.html) 06:43:20 INFO - PROCESS | 5177 | RSS: Main: 200908800 06:43:20 INFO - PROCESS | 5177 | 06:46:22 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52154/tests/dromaeo/cssquery-mootools.html) 06:46:23 INFO - PROCESS | 5177 | RSS: Main: 200577024 06:46:23 INFO - PROCESS | 5177 | 06:49:25 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52154/tests/dromaeo/cssquery-prototype.html) 06:49:26 INFO - PROCESS | 5177 | RSS: Main: 196636672 06:49:26 INFO - PROCESS | 5177 | 06:52:29 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52154/tests/dromaeo/cssquery-yui.html) 06:52:29 INFO - PROCESS | 5177 | RSS: Main: 200429568 06:52:29 INFO - PROCESS | 5177 | 06:55:32 INFO - PROCESS | 5177 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-yui.html (next: http://localhost:52154/tests/dromaeo/cssquery-dojo.html) 06:55:33 INFO - PROCESS | 5177 | RSS: Main: 200654848 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | __start_tp_report 06:55:33 INFO - PROCESS | 5177 | _x_x_mozilla_page_load 06:55:33 INFO - PROCESS | 5177 | _x_x_mozilla_page_load_details 06:55:33 INFO - PROCESS | 5177 | |i|pagename|runs| 06:55:33 INFO - PROCESS | 5177 | |0;dojo.html;2577.317010992087;2582.4835032993406;2591.909283175089;2594.1828324077915;2629.368951451651;4569.657275704319;4692.97653511732;4700.858974230774;4727.409073865767;4740.265258884874;4648.070385922812;4659.394278743767;4714.434267887849;4716.009637976029;4716.9292460613115;4293.570642935712;4317.13657268546;4419.0499042705815;4429.047754732732;4482.193205223059;4320.07118469529;4341.674374421915;4368.868933931987;4404.471463424377;4406.030673251879;4171.124063946575;4220.3036498977635;4223.894402639928;4255.063885945087;4319.805608747614;4243.596858298457;4251.043515209084;4260.936085958713;4269.6370808481315;4338.110687309094;4260.723053001576;4301.784910754481;4302.784860756981;4343.087951530182;4355.041890784022;4637.234856248715;4665.346851440801;4699.906001879977;4730.432348118214;4746.5490778376;5079.74601269935;5082.136036873703;5091.490850914916;5095.0574143783515;5123.308353372285;5104.566111880495;5125.666831655931;5127.051495473349;5128.897422051576;5149.021685879671;4608.723476591348;4651.139539185261;4675.57919787214;4693.20215563355;4761.262004389325;5119.10415677255;5135.666181698178;5135.794568217304;5191.454897235736;5191.84424467259;4908.312836202935;4909;4912.066707325596;4919.926201106986;4976.402831660224;4774.116788394158;4968.875778105504;5010.624203184776;5017.698938063728;5021.978564725609;4856.150173719585;4870.4155501340065;4892.877678058077;4947.604191664658;4960.082384758831;4948.8762780930765;4959.603231741452;4961.603071754251;4979.950200498021;4993.825216117419;3835.6356146166067;3845.3655146900446;3915.530136383652;3919.392494163409;3967.0479085019965;3436.9828150859585;3438.5014172944784;3471.1148657092785;3496.475528670669;3503.404421248394;4322.891927701769;4335.891602709894;4361.716488428242;4374.803133858984;4396.516383197845;4928.67963582366;4994.02616489781;5000.799968001312;5016.749162541858;5074.873128171826;4272.6795490338345;4292.570742925683;4300.247456695066;4309.719868208556;4360.41134446852;4396.626286765661;4411.1618792429335;4413.16149931512;4417.514073451917;4479.619232365286;4532.886677832948;4697.13103075932;4700.6474514410875;4703.74129422885;4747.098051370229;4814.687045342182;4953.281774142802;4975.825846095369;5001.64988450805;5054.570361519312;4728.692634978853;4732.195526760528;4732.621390288838;4735.668503204743;4764.404449443819;4822.204336284614;4827;4894.92657610129;4919.262110683283;4929;4902.558769710743;4918.43438004634;4929.876753081202;4996.60027197816;5003.024410240114;4772.546608072227;4774.307725379731;4781.163296423042;4819.228923372244;4829.913269514331;4712.52874712526;4758.214894542501;4805.639577031667;4821.54195351441;4865.416150062015;4739.075880203327;4740.525947405232;4748.62011039123;4759.95240047609;4796;4807.4471435783935;4834.250691142878;4849.684770489906;4857.101436234308;4860;4702.459217190067;4728.668993170445;4783.402074740658;4834.709917404826;4839.443464001685 06:55:33 INFO - PROCESS | 5177 | |1;ext.html;530.3264853635883;537.7445713286189;540.8837100023494;561.2114978455271;565.0732798210933;36269.274614507725;37949.62050379499;38124.237515249675;42231.15537689244;42361.364579531255;40214.59785402152;40725.185496290054;40731.18537629246;40762.18475630486;40801.79599102008;7364.96317518413;7463.813404664899;7465.178830328659;7490.325870671639;7494.925050749504;7587.772366829004;7713.5757533335645;7714.459987800856;7725.884111738328;7738.883916741225;7590.962045189766;7631;7665.118511371208;7706.6146692665425;7730.961345193295;7605.771826845204;7657.195994420589;7682.615869206517;7715.652795624211;7750.031246094239;7692.615369231572;7760.611969401564;7774.416918731061;7779.299863012299;7781.105172905131;36405.45391819125;36700.63299366999;36972.44541331882;37080;37111.81444092789;2846.050455438011;2976.4642364374404;2990.2374894401787;3105.192649911017;3181.8886338978023;27331.180064598095;27526.0365887195;27545.724542754517;28015.159545213675;28739.71260287391;2996.5055765798616;3026.546018097281;3094.5048792193143;3095.396397702449;3217.1635374802486;236180.99999999828;238110;238194;238207;238467;50063.24905126426;50084.74957625189;50113;50119;50335.74832125816;52431.47568524342;52515.73742131341;52554;52704;52846.735766320926;13542.79685804694;13677.931610341884;13687.520936767165;13704.588862334145;13736.65658358549;10894.782104358026;10921.726956826144;10929.672109836718;10973.286736362112;10977.012068913837;13909.374078166304;14571.198584077978;14639.16290586667;14786.778198327034;14923.104613723212;3004.9248768780953;5845.41545845412;6042.0394006936285;6042.728077236535;6159.6612186330185;752.8230865746546;924.2051835421532;926.6571368593663;926.8331700293877;938.957746901391;26451;27676.723232767818;27909.581356279672;28179.43641127166;28396.290092747848;913.6939125392935;924.7734305095295;948.7722946492792;979.6277414582413;1019.9643012494527;14351.425942962373;14698.926505367619;14887.47893823711;15003.849961500246;15040.172790496408;353247;407563;413529;417005;566465;47146.52853471421;47468.52531474641;47533.28700069502;47669.5233047672;47689.28466073012;1168.456667649547;1176.347127344315;1183.2427246562206;1204.500132445043;1205.0841360565857;25613.743862561136;26783.732162678123;27300.453990919672;27371.452570948866;27399.45201095927;39621.80189099036;40216.79891600523;40320.3951940727;40367.59632403756;40381;218993;220554;220596;220868;221282;24169.154079607128;24583.38541536476;24759.62860557057;25585.616215756407;25702.357441064123;40204;40445.191096177325;40697.38953915634;40921;41322.380164296956;35027.82486087553;35743;35934;36730.081747956516;36887.81556092203;34732.13169670779;35252.82373588115;35316.70249462601;35427.64572354243;35634.287314254085;34012;34849.65150348464;34915;34948.65051349454;35245.29509409849;30449.23876903095;32544.349113017135;32759.508607370433;32878.67121328756;32907.06394040913;23935.401614959766;24158;25280.67849463973;26406.867965660047;27044.07860860125 06:55:33 INFO - PROCESS | 5177 | |2;jquery.html;345.5714913507252;357.878321370734;359.1255293360667;365.6562830938919;381.14623243933596;15195.544133675994;15473.458428954975;16852.662946741057;16936.153192340364;17100.315987360522;15306.464273750422;16686.165691715396;16702.916485417554;16717.331306747714;16722.24749886255;4769.666123371366;5206.505381988724;5224.059669259532;5224.973875130619;5230.790768369261;5093.286939828427;5189.117849965515;5191.87020324493;5192.350956130484;5192.948070519303;4967.279744437054;5147.794088236466;5167.328247327842;5168.508991645787;5175.171972484403;5110.565601923841;5120.359955005624;5143.177091665353;5160.922586161192;5164;4685.367475390813;4961.3798275215595;4987.675801072919;5059.544640982329;5063.873403164914;11117.666470005914;11151.498182581721;11166.776664466664;11299.49152288149;11398;1804.9458516244533;1876.2307453943818;2018.6669199582052;2234.6759719840534;2353.599888019041;8670.612701967655;9211.907880921239;9346.859797103049;11870.931616154501;12470.563530276397;1590.4194968836407;1688.5272123805355;1697.7538256952673;1704.1053446940455;1739.6085880676874;62373;64831;65024;66273;66395.66802166007;8948.68679596211;9100.590473428712;9233.861492077624;9296.209822165056;9315.767105822408;11942.223755456042;12047.759044819055;12079.818802717966;12087.274763514042;12122.515099395925;6440.098386225932;6561.311062338481;6590.637514936629;6686.264510903797;7007.089078419875;6295.338989406138;6307.873842523124;6577.375149360803;6644.468442524587;6819.147606549182;3774.8678796241998;3809.504764380613;3823.235352929425;3868.2456920900154;3884.76691398517;1621.3514594162193;1693.0518909410769;1699.804522479906;1699.9970017689623;1763.3387479695114;828.056016141599;837.1837458478057;847.3983471735137;853.8761879527558;903.20969151992;16147.677046459004;16596.6680666386;16708.08105554206;17194.226259818337;17392.47822565325;824.3487644760692;849.0575461238021;870.5821205821242;874.3943049711894;875.5315905990265;8884;9648.855267170999;9683.370580912218;9745.805083898282;9822.852657210147;272548;275174;379078;381171;381523;74636.26818659046;75661.62169189118;75906.62046689841;77595.22404775993;81395;890.5013192612158;915.6795121707349;915.8259930613162;925.6066171876926;936.7611259129014;14819.481318153812;15423.922880385975;15480;15547.766783498031;16028.278727457526;34574.13564660904;34656;35164.120896976754;35245.29509409746;35395.64604354026;44101.77949110234;49397.25904111513;49423;49429.75285123551;49716;7101.893471598033;7161.641917904188;7270.163931147986;7288.380487658608;7410.666520006721;10039.297249192487;10693.679189624323;10854.40300783433;11110.500027498943;11526.769464610828;9354.111359420844;9545.618175272912;9782.168515675963;9863.852042219229;10465.476726163814;8876.689315873913;8976.955115224382;9682.322237443312;9874.913759486595;10253.641122560974;9171.77070573241;9825.459599722084;9925.305228634215;9990.60037598517;10208.795824083625;6822.965885170543;6929.203141638776;7012.789616311519;7119.572825630479;7278.708851645875;7962.800929976797;8963.686270980485;8998.875140607424;9693.757656058655;10105.19158467306 06:55:33 INFO - PROCESS | 5177 | |3;mootools.html;1219.8536175658921;1267.3979859566707;1308.6705663918224;1580.2335867104453;1596.329541592531;6374.171357723501;6674.532782705212;6886.311368863117;7431.145418276899;7447.925520744784;6966.338197871207;7249.637518124086;7261.745838895639;7385.076865391826;7413.592252426114;2094.06813967784;2104.5370018595886;2122.755883073451;2127.4468638154112;2129.158982202029;2060.2892002259196;2095.832333413331;2120.5122821751006;2121.9257325993594;2128.978710212901;2084.42678263478;2095.9790402095937;2111.229401268534;2112.039022244875;2133.9466513337134;1977.8912159831204;1982.4944639117077;1985.900704964746;1987.3839109875912;1988.2544045982756;1981.8711783734154;2003.0485519378324;2021.2218295956015;2039.1639427834516;2040.0717673458541;7182.461315401366;7370.815729606803;7411.0736157980255;7422.851542969111;7435.814104647373;4132.297509423405;4155;4247.490301163849;4252.510961239466;4253.510846252659;2714.5520989036786;2790.3861150546845;2811.46582149393;2812.6202962600196;2815.2680303121133;822.8726644497018;851.4465597361702;854.6666799948025;877.6226222724226;879.7272845417941;9204.585793639235;9253.167214950687;9304.906950930472;9338.533073346374;9351.625934962593;3632.037510059836;3698.593154752975;3741.3826718591126;3796.8291426885858;3818.904527386782;7479.813004674927;7505.686504861627;7521.9247807522315;7556.848863022708;7563.205863384375;4134.834606615762;4146.91706165881;4150.149219410014;4153.771542565188;4160.563140870226;3488.319777643386;3613.2954073955852;3658.32321020612;3839.539255289383;3847.6537111660086;3118.8908388206305;3173.397054559626;3254.0888551205226;3287.8027318360973;3343.281194543185;958.5015791788231;962.5716556132454;977.3744803325877;998.5805961496189;1008.1128606826093;627.4227710506345;667.2093569120608;716.2121666167175;741.4735537768245;795.7612716185237;4531.171006849819;4570.520095390003;4679.64902632304;4684.859454216379;4692.296155576691;390.9921801563953;398.1420039814205;406.20992170228624;406.8535327282176;408.7813020034327;3208.9358212836078;3283.1792051987004;3310.4041272571167;3330.58367704037;3333.416652085924;8303.709370172015;8568.657253709782;8697.695580654647;8756.518391488402;8772.868406973901;8790.296776257885;8838.955805220932;8841.248493877963;8854;8865.867011994826;6623.172103487161;6645.368689974444;6723.428508576728;6741.730330786713;6757.391834734897;4607.493175750732;4667.533246675305;4708.340832283551;4808.27875818616;4928.482509336468;7866.488678235896;8110.107888132418;8167.632456539352;8240.546769927712;8250.628721707417;8228.177182281725;8289.875651865348;8293.958530207552;8311.210435008665;8394.328453723809;5221.686698798084;5936.643801371932;5978.073398623221;5997.250343707036;6001.489873360813;6046.969765151146;6484.383983521558;6671.733130674718;6706.66466676674;6846.007328937177;6201.503879689524;6294.622322660472;6344.936550634435;6359.20509936258;6378.202724659418;6148;6256.249250090018;6259.530535209969;6281.748730050746;6418.261899881387;5708.942910570841;5744.454276843693;5785.710714464344;5787.189793429007;5787.8553036174435;3965.583613720518;4056.411820285983;4124.051468162399;4133.359329303963;4196.517400498981;4115.42384066225;4155.439015732958;4244.3209086546;4248.256555102783;4299.097189590221 06:55:33 INFO - PROCESS | 5177 | |4;prototype.html;294.9808262462941;295.5684700337507;296.2002592998902;304.8233817464587;305.78442198250235;4944.62915281354;5044.899102017962;5049.2173713074535;5078.1874900016;5089.3129427527365;4917.975410122954;4926.5566099051075;4941.876453088675;4942.901141977159;4954.7274899880495;3641.9635803641954;3773.5094437723196;3787.9242415151816;3864.7487913285545;3895.18201177753;3867.439221312908;3867.4778904847767;3868.2263547290654;3872.554656214529;3902.3366027775205;3857.614238576134;3858.459815625815;3887.3974533947144;3888.5029263733527;3898.5126859142606;3814.141818090935;3825.6610186434527;3827.5789663137034;3891.571927088032;3924.1366899282257;3417.8550185687823;3423.760336776427;3424.7773894697016;3431.4338134207824;3432.742544309162;4871.4397844248015;4880.755962201875;4889.315495830587;4893.975530122327;4929.285253638202;4409.492908315553;4431.911361772746;4432.623227025707;4436.179306828247;4456.19788438081;4904.877378065541;5161.174212126042;5188.5849132069725;5192.584593232532;5233.869153271161;3688.61269566697;3699.3341198584244;3703;3707.9629203707887;3713.702903767692;5442.863928401782;5473.808416705396;5477.3427188737205;5491.670499769986;5505.256790333294;3659.304732100892;3666.651668091527;3696.815159242027;3704.6295370463276;3724.366857634209;3749.7000239980734;3758.774473531597;3775.942736033915;3784.4701741756176;3793.886183414447;4352.347147927773;4359.651227901761;4368.956310436918;4388.122375524844;4397.340398940185;4967.95672908686;5214.366744793855;5256.632035757537;5273.604479664041;5290.888913328167;1312.527490103562;1324.6423465664216;1324.8542660307357;1328.6944002879393;1329.7805862032656;797.6729540888208;827.3215962910356;836.4730219961385;841.469873979389;843.9661414766985;4394.450693663292;4521.88695282614;4538.795754191069;4646.117237724821;4646.535346465326;5310;5354.732263386815;5358.955003774305;5360.678359298455;5366.892662146735;4622.91968614125;4634.443866736014;4640.628749700016;4641.6054635355695;4648;2702.8918843246443;2822.5625028120676;2849.5155823510054;2862.41320529291;2869.253993961543;5025.0402343086225;5079.263506791494;5085.389753229636;5090.40389401408;5113.51421614946;5256.868578285574;5469.753861076261;5479.369872464717;5481.835544933659;5503.229547863302;5049.4599147259705;5052.065367906949;5073.949260507347;5105.310783044316;5106.310648062464;5379;5417.864553386039;5432.782688692566;5457.808976685797;5470.288862447856;5046.394432668103;5214.608904332266;5246.475352464723;5313.229581710708;5317.57459403239;5071.290019397214;5089.829339251919;5119.539241468286;5124.7950081996305;5153.7165455900285;3390.5422767926016;3394.711449526719;3422.6235114136925;3428.63999280072;3443.2252743132594;4813.689429073994;4823.445303790109;4828.03439312146;5036;5330.546903513245;5228.771238758813;5237.973810131078;5241.187615919539;5246.76389562463;5250.238715386171;5243.344581927259;5248.268071536308;5253.684778913277;5302.628815982998;5303.7082960436;4899.387576552931;5156.04613146569;5168.043911876315;5202.583793296451;5218.269442278008;4968.751562421937;5101.285819985131;5160.948390516197;5251.894962100813;5280.788768449219;5097.649122982339;5114.956600822505;5116.980981221098;5132.716820794802;5164.406093299319 06:55:33 INFO - PROCESS | 5177 | |5;yui.html;554.1493807006246;576.1846986514083;606.1786279591154;636;636.2396935661883;11553.53785848565;11691.532338706453;12082.093842961769;12810.615681529558;12890.871091289084;11714.472848721807;11939.34333611651;11954.402279886015;11981;11981.580644677439;526.1870410216206;741.9703211871532;759.4797563668877;759.9012128423298;762.393896852004;567.5431277821352;737.36218171282;756.9053868266467;761.8057395364175;762.6301243896705;798.4969469234375;800.5116878703986;801.6272433318505;801.7594721583531;802.2539038694013;785.4070177016373;789.0176729971193;790.2018960849526;791.4894892794144;791.9128895821455;587.2659176029963;587.5505238492557;587.8471597384668;588.0444278048171;589.4341432225069;11869.52521899123;11925.701857453547;11942.164048516608;11954.940225298906;11961.342126183057;10224.693259202237;12033.278003319829;12611.1802732823;12630.621081367573;12686.492540298377;9243.90756092444;9740.4642744649;9786.804263914682;9789.804203915883;9840.852387214198;3967.563568007517;4028.3353246714255;4046.190761847642;4047.433359329696;4056.918861622751;62103;62928.05607915885;63775.6811215941;63930.6803465989;64074.0388894167;8804.207621314112;9186.219171370374;9481.857772133424;9543.952280238555;9568.186704130088;17678.204480798395;17955.551111222325;17967.910160449115;17982.190801413966;18015.72976405355;5322.680639161663;5468;5486.807961721321;5491.341039075336;5492.752826122834;3383.2725963917874;3438.3123375325035;3457.8098204598987;3494.5282386877952;3549.219171782204;2773.0710212078775;2865.2407112115307;2875.8993435230086;2881.755050820662;2889.0321742216593;495.7124867576797;497.94771548986836;512.6078549909322;524.4283730733518;526.1817873207123;434.4721163786015;479.6594417963285;532.2202972645093;543.2638774460628;574.3825387708231;7171.784846454615;7745.535267883945;7831.78607315867;7842.8431431371055;8243.752687419386;402.8690675530464;431.5835219013667;476.7258826174963;485.77897056839055;529.637198519008;3446.9482957755154;3787.715921305913;3793.7344385893275;3819.102510909934;3901.9609803902167;76541;78592.60703696444;79662.20337796664;88636.5568172155;95769;74359;76904.23095769083;76914.61542692251;78097;80004.19995800084;64366.35633643697;66112.33887661062;68623.65688171628;68990;70228.64885675539;7603.505772125015;7902.446828721934;7965.8406831864195;8317.625706843328;8430.40987130895;28631.42737145287;35889.46165807463;36546.8172659135;38384.42423363707;42207.577924221594;35858.4621230687;37337.4399384004;48535.5146448531;51577.742111289204;54148.729256353465;9700.417974921527;9870.851937220803;10320.277580569287;10584.259101862795;10779.245452818228;10375.792484150426;10429.791404172025;11431.714207144556;11517.42412879336;12262;10272.794544109225;10564.260501764802;10597.15222782191;10757.30077544957;10847.891521084688;10896.400697961371;10939.617113400993;11506.539738410705;11531.481083351102;11532;10416.583336666752;10538.525766340379;10706.625268115578;10979.83530247031;10980.450977451255;9415.964243933026;9624.615015399306;9646.614135434786;9691.951540242253;9733.270004749813;9014.2788576915;9290.535473226448;9523.857142143012;9763.316567840184;9807.460589667351 06:55:33 INFO - PROCESS | 5177 | __end_tp_report 06:55:33 INFO - PROCESS | 5177 | __start_cc_report 06:55:33 INFO - PROCESS | 5177 | _x_x_mozilla_cycle_collect,345 06:55:33 INFO - PROCESS | 5177 | __end_cc_report 06:55:33 INFO - PROCESS | 5177 | __startTimestamp1476280533116__endTimestamp 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | ------- Summary: start ------- 06:55:33 INFO - PROCESS | 5177 | Number of tests: 6 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | [#0] dojo.html Cycles:165 Average:4596.55 Median:4735.67 stddev:508.55 (10.7%) stddev-sans-first:484.81 06:55:33 INFO - PROCESS | 5177 | Values: 2577.3 2582.5 2591.9 2594.2 2629.4 4569.7 4693.0 4700.9 4727.4 4740.3 4648.1 4659.4 4714.4 4716.0 4716.9 4293.6 4317.1 4419.0 4429.0 4482.2 4320.1 4341.7 4368.9 4404.5 4406.0 4171.1 4220.3 4223.9 4255.1 4319.8 4243.6 4251.0 4260.9 4269.6 4338.1 4260.7 4301.8 4302.8 4343.1 4355.0 4637.2 4665.3 4699.9 4730.4 4746.5 5079.7 5082.1 5091.5 5095.1 5123.3 5104.6 5125.7 5127.1 5128.9 5149.0 4608.7 4651.1 4675.6 4693.2 4761.3 5119.1 5135.7 5135.8 5191.5 5191.8 4908.3 4909.0 4912.1 4919.9 4976.4 4774.1 4968.9 5010.6 5017.7 5022.0 4856.2 4870.4 4892.9 4947.6 4960.1 4948.9 4959.6 4961.6 4980.0 4993.8 3835.6 3845.4 3915.5 3919.4 3967.0 3437.0 3438.5 3471.1 3496.5 3503.4 4322.9 4335.9 4361.7 4374.8 4396.5 4928.7 4994.0 5000.8 5016.7 5074.9 4272.7 4292.6 4300.2 4309.7 4360.4 4396.6 4411.2 4413.2 4417.5 4479.6 4532.9 4697.1 4700.6 4703.7 4747.1 4814.7 4953.3 4975.8 5001.6 5054.6 4728.7 4732.2 4732.6 4735.7 4764.4 4822.2 4827.0 4894.9 4919.3 4929.0 4902.6 4918.4 4929.9 4996.6 5003.0 4772.5 4774.3 4781.2 4819.2 4829.9 4712.5 4758.2 4805.6 4821.5 4865.4 4739.1 4740.5 4748.6 4760.0 4796.0 4807.4 4834.3 4849.7 4857.1 4860.0 4702.5 4728.7 4783.4 4834.7 4839.4 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | [#1] ext.html Cycles:180 Average:44901.28 Median:36101.64 stddev:83351.73 (230.9%) stddev-sans-first:83518.97 06:55:33 INFO - PROCESS | 5177 | Values: 530.3 537.7 540.9 561.2 565.1 36269.3 37949.6 38124.2 42231.2 42361.4 40214.6 40725.2 40731.2 40762.2 40801.8 7365.0 7463.8 7465.2 7490.3 7494.9 7587.8 7713.6 7714.5 7725.9 7738.9 7591.0 7631.0 7665.1 7706.6 7731.0 7605.8 7657.2 7682.6 7715.7 7750.0 7692.6 7760.6 7774.4 7779.3 7781.1 36405.5 36700.6 36972.4 37080.0 37111.8 2846.1 2976.5 2990.2 3105.2 3181.9 27331.2 27526.0 27545.7 28015.2 28739.7 2996.5 3026.5 3094.5 3095.4 3217.2 236181.0 238110.0 238194.0 238207.0 238467.0 50063.2 50084.7 50113.0 50119.0 50335.7 52431.5 52515.7 52554.0 52704.0 52846.7 13542.8 13677.9 13687.5 13704.6 13736.7 10894.8 10921.7 10929.7 10973.3 10977.0 13909.4 14571.2 14639.2 14786.8 14923.1 3004.9 5845.4 6042.0 6042.7 6159.7 752.8 924.2 926.7 926.8 939.0 26451.0 27676.7 27909.6 28179.4 28396.3 913.7 924.8 948.8 979.6 1020.0 14351.4 14698.9 14887.5 15003.8 15040.2 353247.0 407563.0 413529.0 417005.0 566465.0 47146.5 47468.5 47533.3 47669.5 47689.3 1168.5 1176.3 1183.2 1204.5 1205.1 25613.7 26783.7 27300.5 27371.5 27399.5 39621.8 40216.8 40320.4 40367.6 40381.0 218993.0 220554.0 220596.0 220868.0 221282.0 24169.2 24583.4 24759.6 25585.6 25702.4 40204.0 40445.2 40697.4 40921.0 41322.4 35027.8 35743.0 35934.0 36730.1 36887.8 34732.1 35252.8 35316.7 35427.6 35634.3 34012.0 34849.7 34915.0 34948.7 35245.3 30449.2 32544.3 32759.5 32878.7 32907.1 23935.4 24158.0 25280.7 26406.9 27044.1 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | [#2] jquery.html Cycles:180 Average:22085.33 Median:5131.77 stddev:56809.45 (1107.0%) stddev-sans-first:56945.36 06:55:33 INFO - PROCESS | 5177 | Values: 345.6 357.9 359.1 365.7 381.1 15195.5 15473.5 16852.7 16936.2 17100.3 15306.5 16686.2 16702.9 16717.3 16722.2 4769.7 5206.5 5224.1 5225.0 5230.8 5093.3 5189.1 5191.9 5192.4 5192.9 4967.3 5147.8 5167.3 5168.5 5175.2 5110.6 5120.4 5143.2 5160.9 5164.0 4685.4 4961.4 4987.7 5059.5 5063.9 11117.7 11151.5 11166.8 11299.5 11398.0 1804.9 1876.2 2018.7 2234.7 2353.6 8670.6 9211.9 9346.9 11870.9 12470.6 1590.4 1688.5 1697.8 1704.1 1739.6 62373.0 64831.0 65024.0 66273.0 66395.7 8948.7 9100.6 9233.9 9296.2 9315.8 11942.2 12047.8 12079.8 12087.3 12122.5 6440.1 6561.3 6590.6 6686.3 7007.1 6295.3 6307.9 6577.4 6644.5 6819.1 3774.9 3809.5 3823.2 3868.2 3884.8 1621.4 1693.1 1699.8 1700.0 1763.3 828.1 837.2 847.4 853.9 903.2 16147.7 16596.7 16708.1 17194.2 17392.5 824.3 849.1 870.6 874.4 875.5 8884.0 9648.9 9683.4 9745.8 9822.9 272548.0 275174.0 379078.0 381171.0 381523.0 74636.3 75661.6 75906.6 77595.2 81395.0 890.5 915.7 915.8 925.6 936.8 14819.5 15423.9 15480.0 15547.8 16028.3 34574.1 34656.0 35164.1 35245.3 35395.6 44101.8 49397.3 49423.0 49429.8 49716.0 7101.9 7161.6 7270.2 7288.4 7410.7 10039.3 10693.7 10854.4 11110.5 11526.8 9354.1 9545.6 9782.2 9863.9 10465.5 8876.7 8977.0 9682.3 9874.9 10253.6 9171.8 9825.5 9925.3 9990.6 10208.8 6823.0 6929.2 7012.8 7119.6 7278.7 7962.8 8963.7 8998.9 9693.8 10105.2 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | [#3] mootools.html Cycles:180 Average:4643.75 Median:5075.08 stddev:2588.47 (51.0%) stddev-sans-first:2582.94 06:55:33 INFO - PROCESS | 5177 | Values: 1219.9 1267.4 1308.7 1580.2 1596.3 6374.2 6674.5 6886.3 7431.1 7447.9 6966.3 7249.6 7261.7 7385.1 7413.6 2094.1 2104.5 2122.8 2127.4 2129.2 2060.3 2095.8 2120.5 2121.9 2129.0 2084.4 2096.0 2111.2 2112.0 2133.9 1977.9 1982.5 1985.9 1987.4 1988.3 1981.9 2003.0 2021.2 2039.2 2040.1 7182.5 7370.8 7411.1 7422.9 7435.8 4132.3 4155.0 4247.5 4252.5 4253.5 2714.6 2790.4 2811.5 2812.6 2815.3 822.9 851.4 854.7 877.6 879.7 9204.6 9253.2 9304.9 9338.5 9351.6 3632.0 3698.6 3741.4 3796.8 3818.9 7479.8 7505.7 7521.9 7556.8 7563.2 4134.8 4146.9 4150.1 4153.8 4160.6 3488.3 3613.3 3658.3 3839.5 3847.7 3118.9 3173.4 3254.1 3287.8 3343.3 958.5 962.6 977.4 998.6 1008.1 627.4 667.2 716.2 741.5 795.8 4531.2 4570.5 4679.6 4684.9 4692.3 391.0 398.1 406.2 406.9 408.8 3208.9 3283.2 3310.4 3330.6 3333.4 8303.7 8568.7 8697.7 8756.5 8772.9 8790.3 8839.0 8841.2 8854.0 8865.9 6623.2 6645.4 6723.4 6741.7 6757.4 4607.5 4667.5 4708.3 4808.3 4928.5 7866.5 8110.1 8167.6 8240.5 8250.6 8228.2 8289.9 8294.0 8311.2 8394.3 5221.7 5936.6 5978.1 5997.3 6001.5 6047.0 6484.4 6671.7 6706.7 6846.0 6201.5 6294.6 6344.9 6359.2 6378.2 6148.0 6256.2 6259.5 6281.7 6418.3 5708.9 5744.5 5785.7 5787.2 5787.9 3965.6 4056.4 4124.1 4133.4 4196.5 4115.4 4155.4 4244.3 4248.3 4299.1 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | [#4] prototype.html Cycles:180 Average:4304.58 Median:4927.92 stddev:1270.44 (25.8%) stddev-sans-first:1237.84 06:55:33 INFO - PROCESS | 5177 | Values: 295.0 295.6 296.2 304.8 305.8 4944.6 5044.9 5049.2 5078.2 5089.3 4918.0 4926.6 4941.9 4942.9 4954.7 3642.0 3773.5 3787.9 3864.7 3895.2 3867.4 3867.5 3868.2 3872.6 3902.3 3857.6 3858.5 3887.4 3888.5 3898.5 3814.1 3825.7 3827.6 3891.6 3924.1 3417.9 3423.8 3424.8 3431.4 3432.7 4871.4 4880.8 4889.3 4894.0 4929.3 4409.5 4431.9 4432.6 4436.2 4456.2 4904.9 5161.2 5188.6 5192.6 5233.9 3688.6 3699.3 3703.0 3708.0 3713.7 5442.9 5473.8 5477.3 5491.7 5505.3 3659.3 3666.7 3696.8 3704.6 3724.4 3749.7 3758.8 3775.9 3784.5 3793.9 4352.3 4359.7 4369.0 4388.1 4397.3 4968.0 5214.4 5256.6 5273.6 5290.9 1312.5 1324.6 1324.9 1328.7 1329.8 797.7 827.3 836.5 841.5 844.0 4394.5 4521.9 4538.8 4646.1 4646.5 5310.0 5354.7 5359.0 5360.7 5366.9 4622.9 4634.4 4640.6 4641.6 4648.0 2702.9 2822.6 2849.5 2862.4 2869.3 5025.0 5079.3 5085.4 5090.4 5113.5 5256.9 5469.8 5479.4 5481.8 5503.2 5049.5 5052.1 5073.9 5105.3 5106.3 5379.0 5417.9 5432.8 5457.8 5470.3 5046.4 5214.6 5246.5 5313.2 5317.6 5071.3 5089.8 5119.5 5124.8 5153.7 3390.5 3394.7 3422.6 3428.6 3443.2 4813.7 4823.4 4828.0 5036.0 5330.5 5228.8 5238.0 5241.2 5246.8 5250.2 5243.3 5248.3 5253.7 5302.6 5303.7 4899.4 5156.0 5168.0 5202.6 5218.3 4968.8 5101.3 5160.9 5251.9 5280.8 5097.6 5115.0 5117.0 5132.7 5164.4 06:55:33 INFO - PROCESS | 5177 | 06:55:33 INFO - PROCESS | 5177 | [#5] yui.html Cycles:180 Average:15921.74 Median:2927.45 stddev:22454.43 (767.0%) stddev-sans-first:22487.77 06:55:33 INFO - PROCESS | 5177 | Values: 554.1 576.2 606.2 636.0 636.2 11553.5 11691.5 12082.1 12810.6 12890.9 11714.5 11939.3 11954.4 11981.0 11981.6 526.2 742.0 759.5 759.9 762.4 567.5 737.4 756.9 761.8 762.6 798.5 800.5 801.6 801.8 802.3 785.4 789.0 790.2 791.5 791.9 587.3 587.6 587.8 588.0 589.4 11869.5 11925.7 11942.2 11954.9 11961.3 10224.7 12033.3 12611.2 12630.6 12686.5 9243.9 9740.5 9786.8 9789.8 9840.9 3967.6 4028.3 4046.2 4047.4 4056.9 62103.0 62928.1 63775.7 63930.7 64074.0 8804.2 9186.2 9481.9 9544.0 9568.2 17678.2 17955.6 17967.9 17982.2 18015.7 5322.7 5468.0 5486.8 5491.3 5492.8 3383.3 3438.3 3457.8 3494.5 3549.2 2773.1 2865.2 2875.9 2881.8 2889.0 495.7 497.9 512.6 524.4 526.2 434.5 479.7 532.2 543.3 574.4 7171.8 7745.5 7831.8 7842.8 8243.8 402.9 431.6 476.7 485.8 529.6 3446.9 3787.7 3793.7 3819.1 3902.0 76541.0 78592.6 79662.2 88636.6 95769.0 74359.0 76904.2 76914.6 78097.0 80004.2 64366.4 66112.3 68623.7 68990.0 70228.6 7603.5 7902.4 7965.8 8317.6 8430.4 28631.4 35889.5 36546.8 38384.4 42207.6 35858.5 37337.4 48535.5 51577.7 54148.7 9700.4 9870.9 10320.3 10584.3 10779.2 10375.8 10429.8 11431.7 11517.4 12262.0 10272.8 10564.3 10597.2 10757.3 10847.9 10896.4 10939.6 11506.5 11531.5 11532.0 10416.6 10538.5 10706.6 10979.8 10980.5 9416.0 9624.6 9646.6 9692.0 9733.3 9014.3 9290.5 9523.9 9763.3 9807.5 06:55:33 INFO - PROCESS | 5177 | -------- Summary: end -------- 06:55:33 INFO - PROCESS | 5177 | 06:55:34 INFO - TEST-INFO | 5177: exit 0 06:55:34 INFO - TEST-OK | dromaeo_css | took 1120408ms 06:55:34 INFO - TEST-START | kraken 06:55:34 INFO - operating with platform_type : linux_ 06:55:34 INFO - Initialising browser for kraken test... 06:55:34 INFO - TEST-INFO | started process 5538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCT3j9c/profile http://localhost:52154/getInfo.html) 06:55:39 INFO - PROCESS | 5538 | __metrics Screen width/height:1600/1200 06:55:39 INFO - PROCESS | 5538 | colorDepth:24 06:55:39 INFO - PROCESS | 5538 | Browser inner width/height: 1024/697 06:55:39 INFO - PROCESS | 5538 | __metrics 06:55:39 ERROR - PROCESS | 5538 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:55:40 INFO - TEST-INFO | 5538: exit 0 06:55:40 INFO - Browser initialized. 06:55:40 INFO - Running cycle 1/1 for kraken test... 06:55:40 INFO - TEST-INFO | started process 5661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCT3j9c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:53 INFO - PROCESS | 5661 | RSS: Main: 188411904 06:55:53 INFO - PROCESS | 5661 | 06:55:56 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:57 INFO - PROCESS | 5661 | RSS: Main: 201465856 06:55:57 INFO - PROCESS | 5661 | 06:55:59 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-dft) 06:56:00 INFO - PROCESS | 5661 | RSS: Main: 199868416 06:56:00 INFO - PROCESS | 5661 | 06:56:03 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-fft) 06:56:04 INFO - PROCESS | 5661 | RSS: Main: 195420160 06:56:04 INFO - PROCESS | 5661 | 06:56:06 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-oscillator) 06:56:06 INFO - PROCESS | 5661 | RSS: Main: 195739648 06:56:06 INFO - PROCESS | 5661 | 06:56:09 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:09 INFO - PROCESS | 5661 | RSS: Main: 195919872 06:56:09 INFO - PROCESS | 5661 | 06:56:13 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52154/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:13 INFO - PROCESS | 5661 | RSS: Main: 195891200 06:56:13 INFO - PROCESS | 5661 | 06:56:17 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52154/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:17 INFO - PROCESS | 5661 | RSS: Main: 193990656 06:56:17 INFO - PROCESS | 5661 | 06:56:20 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52154/tests/kraken/driver.html?testName=json-parse-financial) 06:56:21 INFO - PROCESS | 5661 | RSS: Main: 195018752 06:56:21 INFO - PROCESS | 5661 | 06:56:23 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:23 INFO - PROCESS | 5661 | RSS: Main: 195461120 06:56:23 INFO - PROCESS | 5661 | 06:56:25 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:26 INFO - PROCESS | 5661 | RSS: Main: 195973120 06:56:26 INFO - PROCESS | 5661 | 06:56:28 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:29 INFO - PROCESS | 5661 | RSS: Main: 196268032 06:56:29 INFO - PROCESS | 5661 | 06:56:32 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:33 INFO - PROCESS | 5661 | RSS: Main: 196329472 06:56:33 INFO - PROCESS | 5661 | 06:56:36 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:36 INFO - PROCESS | 5661 | RSS: Main: 196067328 06:56:36 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52154/tests/kraken/driver.html?testName=ai-astar) 06:56:38 INFO - PROCESS | 5661 | RSS: Main: 198819840 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | __start_tp_report 06:56:38 INFO - PROCESS | 5661 | _x_x_mozilla_page_load 06:56:38 INFO - PROCESS | 5661 | _x_x_mozilla_page_load_details 06:56:38 INFO - PROCESS | 5661 | |i|pagename|runs| 06:56:38 INFO - PROCESS | 5661 | |0;ai-astar;115;117;116;117;115;115;114;115;115;115 06:56:38 INFO - PROCESS | 5661 | |1;audio-beat-detection;153;131;132;193;135;133;131;129;155;129 06:56:38 INFO - PROCESS | 5661 | |2;audio-dft;167;174;164;166;163;162;165;162;164;164 06:56:38 INFO - PROCESS | 5661 | |3;audio-fft;77;77;76;110;77;77;77;75;104;76 06:56:38 INFO - PROCESS | 5661 | |4;audio-oscillator;83;84;110;87;84;83;103;84;84;122 06:56:38 INFO - PROCESS | 5661 | |5;imaging-gaussian-blur;118;125;117;118;117;118;119;117;119;118 06:56:38 INFO - PROCESS | 5661 | |6;imaging-darkroom;147;148;147;148;148;149;149;148;147;147 06:56:38 INFO - PROCESS | 5661 | |7;imaging-desaturate;97;98;96;96;96;96;96;95;96;96 06:56:38 INFO - PROCESS | 5661 | |8;json-parse-financial;65;67;64;65;67;67;73;66;67;66 06:56:38 INFO - PROCESS | 5661 | |9;json-stringify-tinderbox;66;68;67;67;67;67;67;67;67;67 06:56:38 INFO - PROCESS | 5661 | |10;stanford-crypto-aes;86;85;86;86;84;86;84;85;93;87 06:56:38 INFO - PROCESS | 5661 | |11;stanford-crypto-ccm;146;145;148;178;140;147;142;154;187;142 06:56:38 INFO - PROCESS | 5661 | |12;stanford-crypto-pbkdf2;176;174;175;176;178;184;184;180;180;182 06:56:38 INFO - PROCESS | 5661 | |13;stanford-crypto-sha256-iterative;74;70;69;77;70;70;71;74;69;71 06:56:38 INFO - PROCESS | 5661 | __end_tp_report 06:56:38 INFO - PROCESS | 5661 | __start_cc_report 06:56:38 INFO - PROCESS | 5661 | _x_x_mozilla_cycle_collect,890 06:56:38 INFO - PROCESS | 5661 | __end_cc_report 06:56:38 INFO - PROCESS | 5661 | __startTimestamp1476280598743__endTimestamp 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | ------- Summary: start ------- 06:56:38 INFO - PROCESS | 5661 | Number of tests: 14 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 06:56:38 INFO - PROCESS | 5661 | Values: 115.0 117.0 116.0 117.0 115.0 115.0 114.0 115.0 115.0 115.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:134.00 stddev:20.28 (15.1%) stddev-sans-first:21.12 06:56:38 INFO - PROCESS | 5661 | Values: 153.0 131.0 132.0 193.0 135.0 133.0 131.0 129.0 155.0 129.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.51 (2.1%) stddev-sans-first:3.66 06:56:38 INFO - PROCESS | 5661 | Values: 167.0 174.0 164.0 166.0 163.0 162.0 165.0 162.0 164.0 164.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:12.95 (16.8%) stddev-sans-first:13.58 06:56:38 INFO - PROCESS | 5661 | Values: 77.0 77.0 76.0 110.0 77.0 77.0 77.0 75.0 104.0 76.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.00 stddev:14.09 (16.8%) stddev-sans-first:14.53 06:56:38 INFO - PROCESS | 5661 | Values: 83.0 84.0 110.0 87.0 84.0 83.0 103.0 84.0 84.0 122.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:2.37 (2.0%) stddev-sans-first:2.50 06:56:38 INFO - PROCESS | 5661 | Values: 118.0 125.0 117.0 118.0 117.0 118.0 119.0 117.0 119.0 118.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:56:38 INFO - PROCESS | 5661 | Values: 147.0 148.0 147.0 148.0 148.0 149.0 149.0 148.0 147.0 147.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:56:38 INFO - PROCESS | 5661 | Values: 97.0 98.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:67.00 stddev:2.45 (3.7%) stddev-sans-first:2.52 06:56:38 INFO - PROCESS | 5661 | Values: 65.0 67.0 64.0 65.0 67.0 67.0 73.0 66.0 67.0 66.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 06:56:38 INFO - PROCESS | 5661 | Values: 66.0 68.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.57 (3.0%) stddev-sans-first:2.73 06:56:38 INFO - PROCESS | 5661 | Values: 86.0 85.0 86.0 86.0 84.0 86.0 84.0 85.0 93.0 87.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:147.50 stddev:16.22 (11.0%) stddev-sans-first:17.01 06:56:38 INFO - PROCESS | 5661 | Values: 146.0 145.0 148.0 178.0 140.0 147.0 142.0 154.0 187.0 142.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:180.00 stddev:3.67 (2.0%) stddev-sans-first:3.73 06:56:38 INFO - PROCESS | 5661 | Values: 176.0 174.0 175.0 176.0 178.0 184.0 184.0 180.0 180.0 182.0 06:56:38 INFO - PROCESS | 5661 | 06:56:38 INFO - PROCESS | 5661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.00 stddev:2.64 (3.7%) stddev-sans-first:2.64 06:56:38 INFO - PROCESS | 5661 | Values: 74.0 70.0 69.0 77.0 70.0 70.0 71.0 74.0 69.0 71.0 06:56:38 INFO - PROCESS | 5661 | -------- Summary: end -------- 06:56:38 INFO - PROCESS | 5661 | 06:56:39 INFO - TEST-INFO | 5661: exit 0 06:56:40 INFO - TEST-OK | kraken | took 65792ms 06:56:40 INFO - SUITE-END | took 1186s 06:56:40 INFO - Completed test suite (00:19:46) 06:56:40 INFO - javascript benchmark 06:56:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6101.642297247823, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.317010992087, 2582.4835032993406, 2591.909283175089, 2594.1828324077915, 2629.368951451651, 4569.657275704319, 4692.97653511732, 4700.858974230774, 4727.409073865767, 4740.265258884874, 4648.070385922812, 4659.394278743767, 4714.434267887849, 4716.009637976029, 4716.9292460613115, 4293.570642935712, 4317.13657268546, 4419.0499042705815, 4429.047754732732, 4482.193205223059, 4320.07118469529, 4341.674374421915, 4368.868933931987, 4404.471463424377, 4406.030673251879, 4171.124063946575, 4220.3036498977635, 4223.894402639928, 4255.063885945087, 4319.805608747614, 4243.596858298457, 4251.043515209084, 4260.936085958713, 4269.6370808481315, 4338.110687309094, 4260.723053001576, 4301.784910754481, 4302.784860756981, 4343.087951530182, 4355.041890784022, 4637.234856248715, 4665.346851440801, 4699.906001879977, 4730.432348118214, 4746.5490778376, 5079.74601269935, 5082.136036873703, 5091.490850914916, 5095.0574143783515, 5123.308353372285, 5104.566111880495, 5125.666831655931, 5127.051495473349, 5128.897422051576, 5149.021685879671, 4608.723476591348, 4651.139539185261, 4675.57919787214, 4693.20215563355, 4761.262004389325, 5119.10415677255, 5135.666181698178, 5135.794568217304, 5191.454897235736, 5191.84424467259, 4908.312836202935, 4909.0, 4912.066707325596, 4919.926201106986, 4976.402831660224, 4774.116788394158, 4968.875778105504, 5010.624203184776, 5017.698938063728, 5021.978564725609, 4856.150173719585, 4870.4155501340065, 4892.877678058077, 4947.604191664658, 4960.082384758831, 4948.8762780930765, 4959.603231741452, 4961.603071754251, 4979.950200498021, 4993.825216117419, 3835.6356146166067, 3845.3655146900446, 3915.530136383652, 3919.392494163409, 3967.0479085019965, 3436.9828150859585, 3438.5014172944784, 3471.1148657092785, 3496.475528670669, 3503.404421248394, 4322.891927701769, 4335.891602709894, 4361.716488428242, 4374.803133858984, 4396.516383197845, 4928.67963582366, 4994.02616489781, 5000.799968001312, 5016.749162541858, 5074.873128171826, 4272.6795490338345, 4292.570742925683, 4300.247456695066, 4309.719868208556, 4360.41134446852, 4396.626286765661, 4411.1618792429335, 4413.16149931512, 4417.514073451917, 4479.619232365286, 4532.886677832948, 4697.13103075932, 4700.6474514410875, 4703.74129422885, 4747.098051370229, 4814.687045342182, 4953.281774142802, 4975.825846095369, 5001.64988450805, 5054.570361519312, 4728.692634978853, 4732.195526760528, 4732.621390288838, 4735.668503204743, 4764.404449443819, 4822.204336284614, 4827.0, 4894.92657610129, 4919.262110683283, 4929.0, 4902.558769710743, 4918.43438004634, 4929.876753081202, 4996.60027197816, 5003.024410240114, 4772.546608072227, 4774.307725379731, 4781.163296423042, 4819.228923372244, 4829.913269514331, 4712.52874712526, 4758.214894542501, 4805.639577031667, 4821.54195351441, 4865.416150062015, 4739.075880203327, 4740.525947405232, 4748.62011039123, 4759.95240047609, 4796.0, 4807.4471435783935, 4834.250691142878, 4849.684770489906, 4857.101436234308, 4860.0, 4702.459217190067, 4728.668993170445, 4783.402074740658, 4834.709917404826, 4839.443464001685], "value": 4562.421820522027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.3264853635883, 537.7445713286189, 540.8837100023494, 561.2114978455271, 565.0732798210933, 36269.274614507725, 37949.62050379499, 38124.237515249675, 42231.15537689244, 42361.364579531255, 40214.59785402152, 40725.185496290054, 40731.18537629246, 40762.18475630486, 40801.79599102008, 7364.96317518413, 7463.813404664899, 7465.178830328659, 7490.325870671639, 7494.925050749504, 7587.772366829004, 7713.5757533335645, 7714.459987800856, 7725.884111738328, 7738.883916741225, 7590.962045189766, 7631.0, 7665.118511371208, 7706.6146692665425, 7730.961345193295, 7605.771826845204, 7657.195994420589, 7682.615869206517, 7715.652795624211, 7750.031246094239, 7692.615369231572, 7760.611969401564, 7774.416918731061, 7779.299863012299, 7781.105172905131, 36405.45391819125, 36700.63299366999, 36972.44541331882, 37080.0, 37111.81444092789, 2846.050455438011, 2976.4642364374404, 2990.2374894401787, 3105.192649911017, 3181.8886338978023, 27331.180064598095, 27526.0365887195, 27545.724542754517, 28015.159545213675, 28739.71260287391, 2996.5055765798616, 3026.546018097281, 3094.5048792193143, 3095.396397702449, 3217.1635374802486, 236180.99999999828, 238110.0, 238194.0, 238207.0, 238467.0, 50063.24905126426, 50084.74957625189, 50113.0, 50119.0, 50335.74832125816, 52431.47568524342, 52515.73742131341, 52554.0, 52704.0, 52846.735766320926, 13542.79685804694, 13677.931610341884, 13687.520936767165, 13704.588862334145, 13736.65658358549, 10894.782104358026, 10921.726956826144, 10929.672109836718, 10973.286736362112, 10977.012068913837, 13909.374078166304, 14571.198584077978, 14639.16290586667, 14786.778198327034, 14923.104613723212, 3004.9248768780953, 5845.41545845412, 6042.0394006936285, 6042.728077236535, 6159.6612186330185, 752.8230865746546, 924.2051835421532, 926.6571368593663, 926.8331700293877, 938.957746901391, 26451.0, 27676.723232767818, 27909.581356279672, 28179.43641127166, 28396.290092747848, 913.6939125392935, 924.7734305095295, 948.7722946492792, 979.6277414582413, 1019.9643012494527, 14351.425942962373, 14698.926505367619, 14887.47893823711, 15003.849961500246, 15040.172790496408, 353247.0, 407563.0, 413529.0, 417005.0, 566465.0, 47146.52853471421, 47468.52531474641, 47533.28700069502, 47669.5233047672, 47689.28466073012, 1168.456667649547, 1176.347127344315, 1183.2427246562206, 1204.500132445043, 1205.0841360565857, 25613.743862561136, 26783.732162678123, 27300.453990919672, 27371.452570948866, 27399.45201095927, 39621.80189099036, 40216.79891600523, 40320.3951940727, 40367.59632403756, 40381.0, 218993.0, 220554.0, 220596.0, 220868.0, 221282.0, 24169.154079607128, 24583.38541536476, 24759.62860557057, 25585.616215756407, 25702.357441064123, 40204.0, 40445.191096177325, 40697.38953915634, 40921.0, 41322.380164296956, 35027.82486087553, 35743.0, 35934.0, 36730.081747956516, 36887.81556092203, 34732.13169670779, 35252.82373588115, 35316.70249462601, 35427.64572354243, 35634.287314254085, 34012.0, 34849.65150348464, 34915.0, 34948.65051349454, 35245.29509409849, 30449.23876903095, 32544.349113017135, 32759.508607370433, 32878.67121328756, 32907.06394040913, 23935.401614959766, 24158.0, 25280.67849463973, 26406.867965660047, 27044.07860860125], "value": 16775.58913557643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.5714913507252, 357.878321370734, 359.1255293360667, 365.6562830938919, 381.14623243933596, 15195.544133675994, 15473.458428954975, 16852.662946741057, 16936.153192340364, 17100.315987360522, 15306.464273750422, 16686.165691715396, 16702.916485417554, 16717.331306747714, 16722.24749886255, 4769.666123371366, 5206.505381988724, 5224.059669259532, 5224.973875130619, 5230.790768369261, 5093.286939828427, 5189.117849965515, 5191.87020324493, 5192.350956130484, 5192.948070519303, 4967.279744437054, 5147.794088236466, 5167.328247327842, 5168.508991645787, 5175.171972484403, 5110.565601923841, 5120.359955005624, 5143.177091665353, 5160.922586161192, 5164.0, 4685.367475390813, 4961.3798275215595, 4987.675801072919, 5059.544640982329, 5063.873403164914, 11117.666470005914, 11151.498182581721, 11166.776664466664, 11299.49152288149, 11398.0, 1804.9458516244533, 1876.2307453943818, 2018.6669199582052, 2234.6759719840534, 2353.599888019041, 8670.612701967655, 9211.907880921239, 9346.859797103049, 11870.931616154501, 12470.563530276397, 1590.4194968836407, 1688.5272123805355, 1697.7538256952673, 1704.1053446940455, 1739.6085880676874, 62373.0, 64831.0, 65024.0, 66273.0, 66395.66802166007, 8948.68679596211, 9100.590473428712, 9233.861492077624, 9296.209822165056, 9315.767105822408, 11942.223755456042, 12047.759044819055, 12079.818802717966, 12087.274763514042, 12122.515099395925, 6440.098386225932, 6561.311062338481, 6590.637514936629, 6686.264510903797, 7007.089078419875, 6295.338989406138, 6307.873842523124, 6577.375149360803, 6644.468442524587, 6819.147606549182, 3774.8678796241998, 3809.504764380613, 3823.235352929425, 3868.2456920900154, 3884.76691398517, 1621.3514594162193, 1693.0518909410769, 1699.804522479906, 1699.9970017689623, 1763.3387479695114, 828.056016141599, 837.1837458478057, 847.3983471735137, 853.8761879527558, 903.20969151992, 16147.677046459004, 16596.6680666386, 16708.08105554206, 17194.226259818337, 17392.47822565325, 824.3487644760692, 849.0575461238021, 870.5821205821242, 874.3943049711894, 875.5315905990265, 8884.0, 9648.855267170999, 9683.370580912218, 9745.805083898282, 9822.852657210147, 272548.0, 275174.0, 379078.0, 381171.0, 381523.0, 74636.26818659046, 75661.62169189118, 75906.62046689841, 77595.22404775993, 81395.0, 890.5013192612158, 915.6795121707349, 915.8259930613162, 925.6066171876926, 936.7611259129014, 14819.481318153812, 15423.922880385975, 15480.0, 15547.766783498031, 16028.278727457526, 34574.13564660904, 34656.0, 35164.120896976754, 35245.29509409746, 35395.64604354026, 44101.77949110234, 49397.25904111513, 49423.0, 49429.75285123551, 49716.0, 7101.893471598033, 7161.641917904188, 7270.163931147986, 7288.380487658608, 7410.666520006721, 10039.297249192487, 10693.679189624323, 10854.40300783433, 11110.500027498943, 11526.769464610828, 9354.111359420844, 9545.618175272912, 9782.168515675963, 9863.852042219229, 10465.476726163814, 8876.689315873913, 8976.955115224382, 9682.322237443312, 9874.913759486595, 10253.641122560974, 9171.77070573241, 9825.459599722084, 9925.305228634215, 9990.60037598517, 10208.795824083625, 6822.965885170543, 6929.203141638776, 7012.789616311519, 7119.572825630479, 7278.708851645875, 7962.800929976797, 8963.686270980485, 8998.875140607424, 9693.757656058655, 10105.19158467306], "value": 7729.514114529088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.8536175658921, 1267.3979859566707, 1308.6705663918224, 1580.2335867104453, 1596.329541592531, 6374.171357723501, 6674.532782705212, 6886.311368863117, 7431.145418276899, 7447.925520744784, 6966.338197871207, 7249.637518124086, 7261.745838895639, 7385.076865391826, 7413.592252426114, 2094.06813967784, 2104.5370018595886, 2122.755883073451, 2127.4468638154112, 2129.158982202029, 2060.2892002259196, 2095.832333413331, 2120.5122821751006, 2121.9257325993594, 2128.978710212901, 2084.42678263478, 2095.9790402095937, 2111.229401268534, 2112.039022244875, 2133.9466513337134, 1977.8912159831204, 1982.4944639117077, 1985.900704964746, 1987.3839109875912, 1988.2544045982756, 1981.8711783734154, 2003.0485519378324, 2021.2218295956015, 2039.1639427834516, 2040.0717673458541, 7182.461315401366, 7370.815729606803, 7411.0736157980255, 7422.851542969111, 7435.814104647373, 4132.297509423405, 4155.0, 4247.490301163849, 4252.510961239466, 4253.510846252659, 2714.5520989036786, 2790.3861150546845, 2811.46582149393, 2812.6202962600196, 2815.2680303121133, 822.8726644497018, 851.4465597361702, 854.6666799948025, 877.6226222724226, 879.7272845417941, 9204.585793639235, 9253.167214950687, 9304.906950930472, 9338.533073346374, 9351.625934962593, 3632.037510059836, 3698.593154752975, 3741.3826718591126, 3796.8291426885858, 3818.904527386782, 7479.813004674927, 7505.686504861627, 7521.9247807522315, 7556.848863022708, 7563.205863384375, 4134.834606615762, 4146.91706165881, 4150.149219410014, 4153.771542565188, 4160.563140870226, 3488.319777643386, 3613.2954073955852, 3658.32321020612, 3839.539255289383, 3847.6537111660086, 3118.8908388206305, 3173.397054559626, 3254.0888551205226, 3287.8027318360973, 3343.281194543185, 958.5015791788231, 962.5716556132454, 977.3744803325877, 998.5805961496189, 1008.1128606826093, 627.4227710506345, 667.2093569120608, 716.2121666167175, 741.4735537768245, 795.7612716185237, 4531.171006849819, 4570.520095390003, 4679.64902632304, 4684.859454216379, 4692.296155576691, 390.9921801563953, 398.1420039814205, 406.20992170228624, 406.8535327282176, 408.7813020034327, 3208.9358212836078, 3283.1792051987004, 3310.4041272571167, 3330.58367704037, 3333.416652085924, 8303.709370172015, 8568.657253709782, 8697.695580654647, 8756.518391488402, 8772.868406973901, 8790.296776257885, 8838.955805220932, 8841.248493877963, 8854.0, 8865.867011994826, 6623.172103487161, 6645.368689974444, 6723.428508576728, 6741.730330786713, 6757.391834734897, 4607.493175750732, 4667.533246675305, 4708.340832283551, 4808.27875818616, 4928.482509336468, 7866.488678235896, 8110.107888132418, 8167.632456539352, 8240.546769927712, 8250.628721707417, 8228.177182281725, 8289.875651865348, 8293.958530207552, 8311.210435008665, 8394.328453723809, 5221.686698798084, 5936.643801371932, 5978.073398623221, 5997.250343707036, 6001.489873360813, 6046.969765151146, 6484.383983521558, 6671.733130674718, 6706.66466676674, 6846.007328937177, 6201.503879689524, 6294.622322660472, 6344.936550634435, 6359.20509936258, 6378.202724659418, 6148.0, 6256.249250090018, 6259.530535209969, 6281.748730050746, 6418.261899881387, 5708.942910570841, 5744.454276843693, 5785.710714464344, 5787.189793429007, 5787.8553036174435, 3965.583613720518, 4056.411820285983, 4124.051468162399, 4133.359329303963, 4196.517400498981, 4115.42384066225, 4155.439015732958, 4244.3209086546, 4248.256555102783, 4299.097189590221], "value": 3693.386484952874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.9808262462941, 295.5684700337507, 296.2002592998902, 304.8233817464587, 305.78442198250235, 4944.62915281354, 5044.899102017962, 5049.2173713074535, 5078.1874900016, 5089.3129427527365, 4917.975410122954, 4926.5566099051075, 4941.876453088675, 4942.901141977159, 4954.7274899880495, 3641.9635803641954, 3773.5094437723196, 3787.9242415151816, 3864.7487913285545, 3895.18201177753, 3867.439221312908, 3867.4778904847767, 3868.2263547290654, 3872.554656214529, 3902.3366027775205, 3857.614238576134, 3858.459815625815, 3887.3974533947144, 3888.5029263733527, 3898.5126859142606, 3814.141818090935, 3825.6610186434527, 3827.5789663137034, 3891.571927088032, 3924.1366899282257, 3417.8550185687823, 3423.760336776427, 3424.7773894697016, 3431.4338134207824, 3432.742544309162, 4871.4397844248015, 4880.755962201875, 4889.315495830587, 4893.975530122327, 4929.285253638202, 4409.492908315553, 4431.911361772746, 4432.623227025707, 4436.179306828247, 4456.19788438081, 4904.877378065541, 5161.174212126042, 5188.5849132069725, 5192.584593232532, 5233.869153271161, 3688.61269566697, 3699.3341198584244, 3703.0, 3707.9629203707887, 3713.702903767692, 5442.863928401782, 5473.808416705396, 5477.3427188737205, 5491.670499769986, 5505.256790333294, 3659.304732100892, 3666.651668091527, 3696.815159242027, 3704.6295370463276, 3724.366857634209, 3749.7000239980734, 3758.774473531597, 3775.942736033915, 3784.4701741756176, 3793.886183414447, 4352.347147927773, 4359.651227901761, 4368.956310436918, 4388.122375524844, 4397.340398940185, 4967.95672908686, 5214.366744793855, 5256.632035757537, 5273.604479664041, 5290.888913328167, 1312.527490103562, 1324.6423465664216, 1324.8542660307357, 1328.6944002879393, 1329.7805862032656, 797.6729540888208, 827.3215962910356, 836.4730219961385, 841.469873979389, 843.9661414766985, 4394.450693663292, 4521.88695282614, 4538.795754191069, 4646.117237724821, 4646.535346465326, 5310.0, 5354.732263386815, 5358.955003774305, 5360.678359298455, 5366.892662146735, 4622.91968614125, 4634.443866736014, 4640.628749700016, 4641.6054635355695, 4648.0, 2702.8918843246443, 2822.5625028120676, 2849.5155823510054, 2862.41320529291, 2869.253993961543, 5025.0402343086225, 5079.263506791494, 5085.389753229636, 5090.40389401408, 5113.51421614946, 5256.868578285574, 5469.753861076261, 5479.369872464717, 5481.835544933659, 5503.229547863302, 5049.4599147259705, 5052.065367906949, 5073.949260507347, 5105.310783044316, 5106.310648062464, 5379.0, 5417.864553386039, 5432.782688692566, 5457.808976685797, 5470.288862447856, 5046.394432668103, 5214.608904332266, 5246.475352464723, 5313.229581710708, 5317.57459403239, 5071.290019397214, 5089.829339251919, 5119.539241468286, 5124.7950081996305, 5153.7165455900285, 3390.5422767926016, 3394.711449526719, 3422.6235114136925, 3428.63999280072, 3443.2252743132594, 4813.689429073994, 4823.445303790109, 4828.03439312146, 5036.0, 5330.546903513245, 5228.771238758813, 5237.973810131078, 5241.187615919539, 5246.76389562463, 5250.238715386171, 5243.344581927259, 5248.268071536308, 5253.684778913277, 5302.628815982998, 5303.7082960436, 4899.387576552931, 5156.04613146569, 5168.043911876315, 5202.583793296451, 5218.269442278008, 4968.751562421937, 5101.285819985131, 5160.948390516197, 5251.894962100813, 5280.788768449219, 5097.649122982339, 5114.956600822505, 5116.980981221098, 5132.716820794802, 5164.406093299319], "value": 3895.52469841954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1493807006246, 576.1846986514083, 606.1786279591154, 636.0, 636.2396935661883, 11553.53785848565, 11691.532338706453, 12082.093842961769, 12810.615681529558, 12890.871091289084, 11714.472848721807, 11939.34333611651, 11954.402279886015, 11981.0, 11981.580644677439, 526.1870410216206, 741.9703211871532, 759.4797563668877, 759.9012128423298, 762.393896852004, 567.5431277821352, 737.36218171282, 756.9053868266467, 761.8057395364175, 762.6301243896705, 798.4969469234375, 800.5116878703986, 801.6272433318505, 801.7594721583531, 802.2539038694013, 785.4070177016373, 789.0176729971193, 790.2018960849526, 791.4894892794144, 791.9128895821455, 587.2659176029963, 587.5505238492557, 587.8471597384668, 588.0444278048171, 589.4341432225069, 11869.52521899123, 11925.701857453547, 11942.164048516608, 11954.940225298906, 11961.342126183057, 10224.693259202237, 12033.278003319829, 12611.1802732823, 12630.621081367573, 12686.492540298377, 9243.90756092444, 9740.4642744649, 9786.804263914682, 9789.804203915883, 9840.852387214198, 3967.563568007517, 4028.3353246714255, 4046.190761847642, 4047.433359329696, 4056.918861622751, 62103.0, 62928.05607915885, 63775.6811215941, 63930.6803465989, 64074.0388894167, 8804.207621314112, 9186.219171370374, 9481.857772133424, 9543.952280238555, 9568.186704130088, 17678.204480798395, 17955.551111222325, 17967.910160449115, 17982.190801413966, 18015.72976405355, 5322.680639161663, 5468.0, 5486.807961721321, 5491.341039075336, 5492.752826122834, 3383.2725963917874, 3438.3123375325035, 3457.8098204598987, 3494.5282386877952, 3549.219171782204, 2773.0710212078775, 2865.2407112115307, 2875.8993435230086, 2881.755050820662, 2889.0321742216593, 495.7124867576797, 497.94771548986836, 512.6078549909322, 524.4283730733518, 526.1817873207123, 434.4721163786015, 479.6594417963285, 532.2202972645093, 543.2638774460628, 574.3825387708231, 7171.784846454615, 7745.535267883945, 7831.78607315867, 7842.8431431371055, 8243.752687419386, 402.8690675530464, 431.5835219013667, 476.7258826174963, 485.77897056839055, 529.637198519008, 3446.9482957755154, 3787.715921305913, 3793.7344385893275, 3819.102510909934, 3901.9609803902167, 76541.0, 78592.60703696444, 79662.20337796664, 88636.5568172155, 95769.0, 74359.0, 76904.23095769083, 76914.61542692251, 78097.0, 80004.19995800084, 64366.35633643697, 66112.33887661062, 68623.65688171628, 68990.0, 70228.64885675539, 7603.505772125015, 7902.446828721934, 7965.8406831864195, 8317.625706843328, 8430.40987130895, 28631.42737145287, 35889.46165807463, 36546.8172659135, 38384.42423363707, 42207.577924221594, 35858.4621230687, 37337.4399384004, 48535.5146448531, 51577.742111289204, 54148.729256353465, 9700.417974921527, 9870.851937220803, 10320.277580569287, 10584.259101862795, 10779.245452818228, 10375.792484150426, 10429.791404172025, 11431.714207144556, 11517.42412879336, 12262.0, 10272.794544109225, 10564.260501764802, 10597.15222782191, 10757.30077544957, 10847.891521084688, 10896.400697961371, 10939.617113400993, 11506.539738410705, 11531.481083351102, 11532.0, 10416.583336666752, 10538.525766340379, 10706.625268115578, 10979.83530247031, 10980.450977451255, 9415.964243933026, 9624.615015399306, 9646.614135434786, 9691.951540242253, 9733.270004749813, 9014.2788576915, 9290.535473226448, 9523.857142143012, 9763.316567840184, 9807.460589667351], "value": 6061.965091873121, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 116.0, 117.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 132.0, 193.0, 135.0, 133.0, 131.0, 129.0, 155.0, 129.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 164.0, 166.0, 163.0, 162.0, 165.0, 162.0, 164.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 110.0, 77.0, 77.0, 77.0, 75.0, 104.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 87.0, 84.0, 83.0, 103.0, 84.0, 84.0, 122.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 125.0, 117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 119.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 149.0, 149.0, 148.0, 147.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 64.0, 65.0, 67.0, 67.0, 73.0, 66.0, 67.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 84.0, 86.0, 84.0, 85.0, 93.0, 87.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 148.0, 178.0, 140.0, 147.0, 142.0, 154.0, 187.0, 142.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 175.0, 176.0, 178.0, 184.0, 184.0, 180.0, 180.0, 182.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 69.0, 77.0, 70.0, 70.0, 71.0, 74.0, 69.0, 71.0], "value": 71.5, "unit": "score"}]}]} 06:56:40 INFO - Return code: 0 06:56:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:56:40 ERROR - # TBPL SUCCESS # 06:56:40 INFO - Running post-action listener: _resource_record_post_action 06:56:40 INFO - [mozharness: 2016-10-12 13:56:40.540080Z] Finished run-tests step (success) 06:56:40 INFO - Running post-run listener: _resource_record_post_run 06:56:40 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402083840; Read time: 12; Write time: 275944 06:56:40 INFO - TinderboxPrint: CPU usage
13.4% 06:56:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:56:40 INFO - TinderboxPrint: I/O write bytes / time
402,083,840 / 275,944 06:56:40 INFO - TinderboxPrint: CPU idle
8,307.9 (86.6%) 06:56:40 INFO - TinderboxPrint: CPU user
1,224.6 (12.8%) 06:56:40 INFO - TinderboxPrint: Swap in / out
0 / 0 06:56:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110776320; Read time: 0; Write time: 61984 06:56:40 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291307520; Read time: 0; Write time: 213960 06:56:41 INFO - Running post-run listener: _upload_blobber_files 06:56:41 INFO - Blob upload gear active. 06:56:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:41 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 06:56:41 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:56:41 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:56:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:42 INFO - (blobuploader) - INFO - Done attempting. 06:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:43 INFO - (blobuploader) - INFO - Done attempting. 06:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:46 INFO - (blobuploader) - INFO - Done attempting. 06:56:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:46 INFO - Return code: 0 06:56:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9bf35459defb3bc4b6010a5bc656f3803ba92b68c31077dd1148d7bdc5e90bdaf976bdd123505e6d8dacf94b9619b6f2885379d3af1f4a25336889a25abd12d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d16c14f15aaebed3c5f8edc7ca0fd6a97f0027aeb85c14b61ea71cf23e588d7a1117936d04c45c6233e93033399ed7219dc835a218f07e98ab850e32f3be93c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e94464969c061bcc27ef63471c2c537b0835828c1879b3969cef47e6bac27393872afef71304fe12b9791b6b780e043f66420d909d0b1337c4d937dd7c8aa370"} 06:56:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:46 INFO - Contents: 06:56:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9bf35459defb3bc4b6010a5bc656f3803ba92b68c31077dd1148d7bdc5e90bdaf976bdd123505e6d8dacf94b9619b6f2885379d3af1f4a25336889a25abd12d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d16c14f15aaebed3c5f8edc7ca0fd6a97f0027aeb85c14b61ea71cf23e588d7a1117936d04c45c6233e93033399ed7219dc835a218f07e98ab850e32f3be93c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e94464969c061bcc27ef63471c2c537b0835828c1879b3969cef47e6bac27393872afef71304fe12b9791b6b780e043f66420d909d0b1337c4d937dd7c8aa370"} 06:56:46 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:46 INFO - Copying logs to upload dir... 06:56:46 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.571374 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-12 06:56:46.306431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:46.309584) ========= 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=41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914 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/Larch-Non-PGO/sha512/9bf35459defb3bc4b6010a5bc656f3803ba92b68c31077dd1148d7bdc5e90bdaf976bdd123505e6d8dacf94b9619b6f2885379d3af1f4a25336889a25abd12d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d16c14f15aaebed3c5f8edc7ca0fd6a97f0027aeb85c14b61ea71cf23e588d7a1117936d04c45c6233e93033399ed7219dc835a218f07e98ab850e32f3be93c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e94464969c061bcc27ef63471c2c537b0835828c1879b3969cef47e6bac27393872afef71304fe12b9791b6b780e043f66420d909d0b1337c4d937dd7c8aa370"} build_url:https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9bf35459defb3bc4b6010a5bc656f3803ba92b68c31077dd1148d7bdc5e90bdaf976bdd123505e6d8dacf94b9619b6f2885379d3af1f4a25336889a25abd12d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d16c14f15aaebed3c5f8edc7ca0fd6a97f0027aeb85c14b61ea71cf23e588d7a1117936d04c45c6233e93033399ed7219dc835a218f07e98ab850e32f3be93c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e94464969c061bcc27ef63471c2c537b0835828c1879b3969cef47e6bac27393872afef71304fe12b9791b6b780e043f66420d909d0b1337c4d937dd7c8aa370"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:46.334714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:46.335037) ========= 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=41bf3e9aed84707956354da8000001c5-1476276164.125109-1991551914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:46.420019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:56:46.420353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:56:46.420634) ========= ========= Total master_lag: 0.17 =========