builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1472549626.79 results: success (0) buildid: 20160830010820 builduid: 7e2903cb159945c898d40f58c0c1aeb0 revision: bc60cb47882ac16cd4bade1e2d0e2623130f2e9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:46.788202) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:46.788843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:46.789129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:46.846103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:46.846452) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1472549238.871303-838109831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 02:33:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.1M=0s 2016-08-30 02:33:47 (50.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130130 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.176218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.176792) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1472549238.871303-838109831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.231126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.231476) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev bc60cb47882ac16cd4bade1e2d0e2623130f2e9b --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 bc60cb47882ac16cd4bade1e2d0e2623130f2e9b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1472549238.871303-838109831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 02:33:47,857 truncating revision to first 12 chars 2016-08-30 02:33:47,857 Setting DEBUG logging. 2016-08-30 02:33:47,858 attempt 1/10 2016-08-30 02:33:47,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/bc60cb47882a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 02:33:48,138 unpacking tar archive at: larch-bc60cb47882a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.802653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.802977) ========= script_repo_revision: bc60cb47882ac16cd4bade1e2d0e2623130f2e9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.806066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.806334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 02:33:47.816773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-30 02:33:47.817139) ========= /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=df17445c3590ff7897617a0e00000225-1472549238.871303-838109831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:33:48 INFO - MultiFileLogger online at 20160830 02:33:48 in /builds/slave/test 02:33:48 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 02:33:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:48 INFO - {'append_to_log': False, 02:33:48 INFO - 'base_work_dir': '/builds/slave/test', 02:33:48 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 02:33:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:48 INFO - 'branch': 'Larch-Non-PGO', 02:33:48 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:48 INFO - 'config_files': ('talos/linux_config.py',), 02:33:48 INFO - 'default_actions': ('clobber', 02:33:48 INFO - 'read-buildbot-config', 02:33:48 INFO - 'download-and-extract', 02:33:48 INFO - 'populate-webroot', 02:33:48 INFO - 'create-virtualenv', 02:33:48 INFO - 'install', 02:33:48 INFO - 'run-tests'), 02:33:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:48 INFO - 'download_minidump_stackwalk': True, 02:33:48 INFO - 'download_symbols': 'ondemand', 02:33:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:48 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:48 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:48 INFO - 'installer_path': 'installer.exe', 02:33:48 INFO - 'log_level': 'info', 02:33:48 INFO - 'log_name': 'talos', 02:33:48 INFO - 'log_to_console': True, 02:33:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:33:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:33:48 INFO - 'opt_config_files': (), 02:33:48 INFO - 'pip_index': False, 02:33:48 INFO - 'sps_profile': False, 02:33:48 INFO - 'sps_profile_interval': 0, 02:33:48 INFO - 'suite': 'dromaeojs-e10s', 02:33:48 INFO - 'system_bits': '32', 02:33:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:48 INFO - 'title': 'talos-linux64-ix-021', 02:33:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:48 INFO - 'use_talos_json': True, 02:33:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:48 INFO - 'work_dir': 'build'} 02:33:48 INFO - [mozharness: 2016-08-30 09:33:48.533387Z] Running clobber step. 02:33:48 INFO - Running pre-action listener: _resource_record_pre_action 02:33:48 INFO - Running main action method: clobber 02:33:48 INFO - rmtree: /builds/slave/test/build 02:33:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:48 INFO - Running post-action listener: _resource_record_post_action 02:33:48 INFO - [mozharness: 2016-08-30 09:33:48.997352Z] Finished clobber step (success) 02:33:48 INFO - [mozharness: 2016-08-30 09:33:48.997457Z] Running read-buildbot-config step. 02:33:48 INFO - Running pre-action listener: _resource_record_pre_action 02:33:48 INFO - Running main action method: read_buildbot_config 02:33:48 INFO - Using buildbot properties: 02:33:48 INFO - { 02:33:48 INFO - "project": "", 02:33:48 INFO - "product": "firefox", 02:33:48 INFO - "script_repo_revision": "production", 02:33:48 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 02:33:48 INFO - "repository": "", 02:33:48 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 02:33:48 INFO - "buildid": "20160830010820", 02:33:48 INFO - "pgo_build": "False", 02:33:48 INFO - "basedir": "/builds/slave/test", 02:33:48 INFO - "buildnumber": 1, 02:33:48 INFO - "slavename": "talos-linux64-ix-021", 02:33:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:33:48 INFO - "platform": "ubuntu64_hw", 02:33:48 INFO - "scheduler": "tests-larch-linux64-talos", 02:33:48 INFO - "branch": "larch", 02:33:48 INFO - "repo_path": "projects/larch", 02:33:48 INFO - "revision": "bc60cb47882ac16cd4bade1e2d0e2623130f2e9b", 02:33:48 INFO - "stage_platform": "linux64", 02:33:48 INFO - "builduid": "7e2903cb159945c898d40f58c0c1aeb0", 02:33:48 INFO - "slavebuilddir": "test" 02:33:48 INFO - } 02:33:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:33:48 INFO - Running post-action listener: _resource_record_post_action 02:33:48 INFO - [mozharness: 2016-08-30 09:33:48.999936Z] Finished read-buildbot-config step (success) 02:33:49 INFO - [mozharness: 2016-08-30 09:33:49.000030Z] Running download-and-extract step. 02:33:49 INFO - Running pre-action listener: _resource_record_pre_action 02:33:49 INFO - Running main action method: download_and_extract 02:33:49 INFO - mkdir: /builds/slave/test/build/tests 02:33:49 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')]} 02:33:49 INFO - trying https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:33:49 INFO - Downloading https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:33:49 INFO - Downloaded 1361 bytes. 02:33:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:33:49 INFO - Using the following test package requirements: 02:33:49 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:33:49 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:33:49 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:33:49 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'jsshell-linux-x86_64.zip'], 02:33:49 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:33:49 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:33:49 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:33:49 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:33:49 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:33:49 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:33:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:33:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:33:49 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')]} 02:33:49 INFO - trying https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:33:49 INFO - Downloading https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:33:50 INFO - Downloaded 20305117 bytes. 02:33:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:33:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:33:54 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')]} 02:33:54 INFO - trying https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:33:54 INFO - Downloading https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:33:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:33:55 INFO - Downloaded 20305117 bytes. 02:33:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:34: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')]} 02:34:00 INFO - trying https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:34:00 INFO - Downloading https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:34:00 INFO - Downloaded 14413998 bytes. 02:34:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 02:34:01 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')]} 02:34:01 INFO - trying https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:34:02 INFO - Downloaded 55887035 bytes. 02:34:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:34:02 INFO - mkdir: /builds/slave/test/properties 02:34:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:34:02 INFO - Writing to file /builds/slave/test/properties/build_url 02:34:02 INFO - Contents: 02:34:02 INFO - build_url:https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:34:02 INFO - Running post-action listener: _resource_record_post_action 02:34:02 INFO - Running post-action listener: set_extra_try_arguments 02:34:02 INFO - [mozharness: 2016-08-30 09:34:02.893322Z] Finished download-and-extract step (success) 02:34:02 INFO - [mozharness: 2016-08-30 09:34:02.893622Z] Running populate-webroot step. 02:34:02 INFO - Running pre-action listener: _resource_record_pre_action 02:34:02 INFO - Running main action method: populate_webroot 02:34:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:34:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:34:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:34:02 INFO - '--tppagecycles', 02:34:02 INFO - '7'], 02:34:02 INFO - 'tests': ['tsvgm']}}, 02:34:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:34:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:34:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:34:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:34:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['damp', 'tps']}, 02:34:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'tests': ['damp', 'tps']}, 02:34:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['dromaeo_dom']}, 02:34:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:34:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['basic_compositor_video']}, 02:34:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:34:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['a11yr', 02:34:02 INFO - 'ts_paint', 02:34:02 INFO - 'tpaint', 02:34:02 INFO - 'sessionrestore', 02:34:02 INFO - 'sessionrestore_no_auto_restore', 02:34:02 INFO - 'tabpaint']}, 02:34:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:34:02 INFO - 'ts_paint', 02:34:02 INFO - 'tpaint', 02:34:02 INFO - 'sessionrestore', 02:34:02 INFO - 'sessionrestore_no_auto_restore', 02:34:02 INFO - 'tabpaint']}, 02:34:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:34:02 INFO - 'ts_paint', 02:34:02 INFO - 'tpaint', 02:34:02 INFO - 'sessionrestore', 02:34:02 INFO - 'sessionrestore_no_auto_restore', 02:34:02 INFO - 'tabpaint']}, 02:34:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:34:02 INFO - 'ts_paint', 02:34:02 INFO - 'tpaint', 02:34:02 INFO - 'sessionrestore', 02:34:02 INFO - 'sessionrestore_no_auto_restore', 02:34:02 INFO - 'tabpaint']}, 02:34:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['a11yr', 02:34:02 INFO - 'ts_paint', 02:34:02 INFO - 'tpaint', 02:34:02 INFO - 'sessionrestore', 02:34:02 INFO - 'sessionrestore_no_auto_restore', 02:34:02 INFO - 'tabpaint']}, 02:34:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['a11yr', 02:34:02 INFO - 'ts_paint', 02:34:02 INFO - 'tpaint', 02:34:02 INFO - 'sessionrestore', 02:34:02 INFO - 'sessionrestore_no_auto_restore', 02:34:02 INFO - 'tabpaint']}, 02:34:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['tsvgx', 02:34:02 INFO - 'tsvgr_opacity', 02:34:02 INFO - 'tart', 02:34:02 INFO - 'tscrollx', 02:34:02 INFO - 'cart']}, 02:34:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:34:02 INFO - 'tsvgr_opacity', 02:34:02 INFO - 'tart', 02:34:02 INFO - 'tscrollx', 02:34:02 INFO - 'cart']}, 02:34:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'talos_options': ['--disable-e10s'], 02:34:02 INFO - 'tests': ['tp5o']}, 02:34:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'tests': ['tp5o']}, 02:34:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'talos_options': ['--disable-e10s', 02:34:02 INFO - '--xperf_path', 02:34:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:02 INFO - 'tests': ['tp5n']}, 02:34:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:02 INFO - 'talos_options': ['--xperf_path', 02:34:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:02 INFO - 'tests': ['tp5n']}}, 02:34:02 INFO - 'talos.zip': {'path': '', 02:34:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:34:02 INFO - Running post-action listener: _resource_record_post_action 02:34:02 INFO - [mozharness: 2016-08-30 09:34:02.910780Z] Finished populate-webroot step (success) 02:34:02 INFO - [mozharness: 2016-08-30 09:34:02.910875Z] Running create-virtualenv step. 02:34:02 INFO - Running pre-action listener: _resource_record_pre_action 02:34:02 INFO - Running main action method: create_virtualenv 02:34:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:34:02 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 02:34:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:34:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:34:03 INFO - Using real prefix '/usr' 02:34:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:34:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:34:05 INFO - Installing pip.................done. 02:34:05 INFO - Return code: 0 02:34:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:34:05 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')]} 02:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:05 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')]} 02:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:05 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:05 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 02:34:05 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 02:34:05 INFO - Using env: {'DISPLAY': ':0', 02:34:05 INFO - 'HOME': '/home/cltbld', 02:34:05 INFO - 'LANG': 'en_US.UTF-8', 02:34:05 INFO - 'LANGUAGE': 'en_US:en', 02:34:05 INFO - 'LOGNAME': 'cltbld', 02:34:05 INFO - 'MAIL': '/var/mail/cltbld', 02:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:05 INFO - 'MOZ_NO_REMOTE': '1', 02:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:05 INFO - 'NO_EM_RESTART': '1', 02:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:05 INFO - 'PWD': '/builds/slave/test', 02:34:05 INFO - 'SHELL': '/bin/bash', 02:34:05 INFO - 'SHLVL': '1', 02:34:05 INFO - 'TERM': 'linux', 02:34:05 INFO - 'TMOUT': '86400', 02:34:05 INFO - 'USER': 'cltbld', 02:34:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:05 INFO - '_': '/tools/buildbot/bin/python'} 02:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:05 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 02:34:05 INFO - Cleaning up... 02:34:05 INFO - Return code: 0 02:34:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:34:05 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')]} 02:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:05 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')]} 02:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:05 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:05 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 02:34:05 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 02:34:05 INFO - Using env: {'DISPLAY': ':0', 02:34:05 INFO - 'HOME': '/home/cltbld', 02:34:05 INFO - 'LANG': 'en_US.UTF-8', 02:34:05 INFO - 'LANGUAGE': 'en_US:en', 02:34:05 INFO - 'LOGNAME': 'cltbld', 02:34:05 INFO - 'MAIL': '/var/mail/cltbld', 02:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:05 INFO - 'MOZ_NO_REMOTE': '1', 02:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:05 INFO - 'NO_EM_RESTART': '1', 02:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:05 INFO - 'PWD': '/builds/slave/test', 02:34:05 INFO - 'SHELL': '/bin/bash', 02:34:05 INFO - 'SHLVL': '1', 02:34:05 INFO - 'TERM': 'linux', 02:34:05 INFO - 'TMOUT': '86400', 02:34:05 INFO - 'USER': 'cltbld', 02:34:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:05 INFO - '_': '/tools/buildbot/bin/python'} 02:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:05 INFO - Downloading/unpacking psutil>=3.1.1 02:34:05 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 02:34:05 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 02:34:05 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 02:34:05 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 02:34:05 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 02:34:05 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 02:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:34:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:07 INFO - Installing collected packages: psutil 02:34:07 INFO - Running setup.py install for psutil 02:34:08 INFO - building 'psutil._psutil_linux' extension 02:34:08 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 02:34:08 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 02:34:08 INFO - building 'psutil._psutil_posix' extension 02:34:08 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 02:34:08 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 02:34:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:08 INFO - Successfully installed psutil 02:34:08 INFO - Cleaning up... 02:34:08 INFO - Return code: 0 02:34:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:34:08 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')]} 02:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:08 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')]} 02:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:08 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:08 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 02:34:08 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 02:34:08 INFO - Using env: {'DISPLAY': ':0', 02:34:08 INFO - 'HOME': '/home/cltbld', 02:34:08 INFO - 'LANG': 'en_US.UTF-8', 02:34:08 INFO - 'LANGUAGE': 'en_US:en', 02:34:08 INFO - 'LOGNAME': 'cltbld', 02:34:08 INFO - 'MAIL': '/var/mail/cltbld', 02:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:08 INFO - 'MOZ_NO_REMOTE': '1', 02:34:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:08 INFO - 'NO_EM_RESTART': '1', 02:34:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:08 INFO - 'PWD': '/builds/slave/test', 02:34:08 INFO - 'SHELL': '/bin/bash', 02:34:08 INFO - 'SHLVL': '1', 02:34:08 INFO - 'TERM': 'linux', 02:34:08 INFO - 'TMOUT': '86400', 02:34:08 INFO - 'USER': 'cltbld', 02:34:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:08 INFO - '_': '/tools/buildbot/bin/python'} 02:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:34:08 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 02:34:08 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 02:34:08 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 02:34:08 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 02:34:08 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 02:34:08 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 02:34:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:34:10 INFO - Installing collected packages: mozsystemmonitor 02:34:10 INFO - Running setup.py install for mozsystemmonitor 02:34:11 INFO - Successfully installed mozsystemmonitor 02:34:11 INFO - Cleaning up... 02:34:11 INFO - Return code: 0 02:34:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:11 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:11 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 02:34:11 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 02:34:11 INFO - Using env: {'DISPLAY': ':0', 02:34:11 INFO - 'HOME': '/home/cltbld', 02:34:11 INFO - 'LANG': 'en_US.UTF-8', 02:34:11 INFO - 'LANGUAGE': 'en_US:en', 02:34:11 INFO - 'LOGNAME': 'cltbld', 02:34:11 INFO - 'MAIL': '/var/mail/cltbld', 02:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:11 INFO - 'MOZ_NO_REMOTE': '1', 02:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:11 INFO - 'NO_EM_RESTART': '1', 02:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:11 INFO - 'PWD': '/builds/slave/test', 02:34:11 INFO - 'SHELL': '/bin/bash', 02:34:11 INFO - 'SHLVL': '1', 02:34:11 INFO - 'TERM': 'linux', 02:34:11 INFO - 'TMOUT': '86400', 02:34:11 INFO - 'USER': 'cltbld', 02:34:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:11 INFO - '_': '/tools/buildbot/bin/python'} 02:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:11 INFO - Downloading/unpacking jsonschema==2.5.1 02:34:11 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 02:34:11 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 02:34:11 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 02:34:11 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 02:34:11 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 02:34:11 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 02:34:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:34:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:34:13 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 02:34:13 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 02:34:13 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 02:34:13 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 02:34:13 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 02:34:13 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 02:34:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:34:13 INFO - warning: no files found matching '*.txt' 02:34:13 INFO - no previously-included directories found matching 'build' 02:34:13 INFO - no previously-included directories found matching 'dist' 02:34:13 INFO - no previously-included directories found matching '.git*' 02:34:13 INFO - Installing collected packages: jsonschema, functools32 02:34:13 INFO - Running setup.py install for functools32 02:34:13 INFO - warning: no files found matching '*.txt' 02:34:13 INFO - no previously-included directories found matching 'build' 02:34:13 INFO - no previously-included directories found matching 'dist' 02:34:13 INFO - no previously-included directories found matching '.git*' 02:34:13 INFO - Successfully installed jsonschema functools32 02:34:13 INFO - Cleaning up... 02:34:13 INFO - Return code: 0 02:34:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:34:13 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')]} 02:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:13 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')]} 02:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:13 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:13 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 02:34:13 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 02:34:13 INFO - Using env: {'DISPLAY': ':0', 02:34:13 INFO - 'HOME': '/home/cltbld', 02:34:13 INFO - 'LANG': 'en_US.UTF-8', 02:34:13 INFO - 'LANGUAGE': 'en_US:en', 02:34:13 INFO - 'LOGNAME': 'cltbld', 02:34:13 INFO - 'MAIL': '/var/mail/cltbld', 02:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:13 INFO - 'MOZ_NO_REMOTE': '1', 02:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:13 INFO - 'NO_EM_RESTART': '1', 02:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:13 INFO - 'PWD': '/builds/slave/test', 02:34:13 INFO - 'SHELL': '/bin/bash', 02:34:13 INFO - 'SHLVL': '1', 02:34:13 INFO - 'TERM': 'linux', 02:34:13 INFO - 'TMOUT': '86400', 02:34:13 INFO - 'USER': 'cltbld', 02:34:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:13 INFO - '_': '/tools/buildbot/bin/python'} 02:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:34:13 INFO - Cleaning up... 02:34:13 INFO - Return code: 0 02:34:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:34:13 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')]} 02:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:13 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')]} 02:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:13 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:13 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 02:34:13 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 02:34:13 INFO - Using env: {'DISPLAY': ':0', 02:34:13 INFO - 'HOME': '/home/cltbld', 02:34:13 INFO - 'LANG': 'en_US.UTF-8', 02:34:13 INFO - 'LANGUAGE': 'en_US:en', 02:34:13 INFO - 'LOGNAME': 'cltbld', 02:34:13 INFO - 'MAIL': '/var/mail/cltbld', 02:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:13 INFO - 'MOZ_NO_REMOTE': '1', 02:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:13 INFO - 'NO_EM_RESTART': '1', 02:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:13 INFO - 'PWD': '/builds/slave/test', 02:34:13 INFO - 'SHELL': '/bin/bash', 02:34:13 INFO - 'SHLVL': '1', 02:34:13 INFO - 'TERM': 'linux', 02:34:13 INFO - 'TMOUT': '86400', 02:34:13 INFO - 'USER': 'cltbld', 02:34:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:13 INFO - '_': '/tools/buildbot/bin/python'} 02:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 02:34:14 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 02:34:14 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 02:34:14 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 02:34:14 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 02:34:14 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 02:34:14 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 02:34:15 INFO - Downloading blobuploader-1.2.4.tar.gz 02:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:34:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:34:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:16 INFO - Downloading docopt-0.6.1.tar.gz 02:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:34:16 INFO - Installing collected packages: blobuploader, requests, docopt 02:34:16 INFO - Running setup.py install for blobuploader 02:34:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:34:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:34:16 INFO - Running setup.py install for requests 02:34:17 INFO - Running setup.py install for docopt 02:34:17 INFO - Successfully installed blobuploader requests docopt 02:34:17 INFO - Cleaning up... 02:34:17 INFO - Return code: 0 02:34:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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')]} 02:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:17 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:17 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 02:34:17 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 02:34:17 INFO - Using env: {'DISPLAY': ':0', 02:34:17 INFO - 'HOME': '/home/cltbld', 02:34:17 INFO - 'LANG': 'en_US.UTF-8', 02:34:17 INFO - 'LANGUAGE': 'en_US:en', 02:34:17 INFO - 'LOGNAME': 'cltbld', 02:34:17 INFO - 'MAIL': '/var/mail/cltbld', 02:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:17 INFO - 'MOZ_NO_REMOTE': '1', 02:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:17 INFO - 'NO_EM_RESTART': '1', 02:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:17 INFO - 'PWD': '/builds/slave/test', 02:34:17 INFO - 'SHELL': '/bin/bash', 02:34:17 INFO - 'SHLVL': '1', 02:34:17 INFO - 'TERM': 'linux', 02:34:17 INFO - 'TMOUT': '86400', 02:34:17 INFO - 'USER': 'cltbld', 02:34:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:17 INFO - '_': '/tools/buildbot/bin/python'} 02:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:17 INFO - Running setup.py (path:/tmp/pip-o01V4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:17 INFO - Running setup.py (path:/tmp/pip-dxd7EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:17 INFO - Running setup.py (path:/tmp/pip-VC9h36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:17 INFO - Running setup.py (path:/tmp/pip-X3NGDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:17 INFO - Running setup.py (path:/tmp/pip-np3xYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:17 INFO - Running setup.py (path:/tmp/pip-ZGsfPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:17 INFO - Running setup.py (path:/tmp/pip-9BCRHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:18 INFO - Running setup.py (path:/tmp/pip-YWI386-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:18 INFO - Running setup.py (path:/tmp/pip-R5Ygi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:18 INFO - Running setup.py (path:/tmp/pip-FN7jX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:18 INFO - Running setup.py (path:/tmp/pip-0VxrYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:18 INFO - Running setup.py (path:/tmp/pip-HfCEWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:18 INFO - Running setup.py (path:/tmp/pip-eEagk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:18 INFO - Running setup.py (path:/tmp/pip-Vwb5ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:18 INFO - Running setup.py (path:/tmp/pip-fiCvQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:18 INFO - Running setup.py (path:/tmp/pip-R05xaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:18 INFO - Running setup.py (path:/tmp/pip-d870VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:34:18 INFO - Running setup.py install for manifestparser 02:34:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:34:18 INFO - Running setup.py install for mozcrash 02:34:18 INFO - Running setup.py install for mozdebug 02:34:19 INFO - Running setup.py install for mozdevice 02:34:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozfile 02:34:19 INFO - Running setup.py install for mozhttpd 02:34:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozinfo 02:34:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozInstall 02:34:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozleak 02:34:19 INFO - Running setup.py install for mozlog 02:34:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for moznetwork 02:34:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozprocess 02:34:19 INFO - Running setup.py install for mozprofile 02:34:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozrunner 02:34:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozscreenshot 02:34:20 INFO - Running setup.py install for moztest 02:34:20 INFO - Running setup.py install for mozversion 02:34:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:34:20 INFO - Cleaning up... 02:34:20 INFO - Return code: 0 02:34:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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')]} 02:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:20 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:20 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 02:34:20 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 02:34:20 INFO - Using env: {'DISPLAY': ':0', 02:34:20 INFO - 'HOME': '/home/cltbld', 02:34:20 INFO - 'LANG': 'en_US.UTF-8', 02:34:20 INFO - 'LANGUAGE': 'en_US:en', 02:34:20 INFO - 'LOGNAME': 'cltbld', 02:34:20 INFO - 'MAIL': '/var/mail/cltbld', 02:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:20 INFO - 'MOZ_NO_REMOTE': '1', 02:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:20 INFO - 'NO_EM_RESTART': '1', 02:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:20 INFO - 'PWD': '/builds/slave/test', 02:34:20 INFO - 'SHELL': '/bin/bash', 02:34:20 INFO - 'SHLVL': '1', 02:34:20 INFO - 'TERM': 'linux', 02:34:20 INFO - 'TMOUT': '86400', 02:34:20 INFO - 'USER': 'cltbld', 02:34:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:20 INFO - '_': '/tools/buildbot/bin/python'} 02:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:20 INFO - Running setup.py (path:/tmp/pip-sT4FvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:20 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)) 02:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:20 INFO - Running setup.py (path:/tmp/pip-H_2mqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:20 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)) 02:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:20 INFO - Running setup.py (path:/tmp/pip-imCLw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:20 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)) 02:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:20 INFO - Running setup.py (path:/tmp/pip-Oo8JJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:21 INFO - Running setup.py (path:/tmp/pip-rmyVyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:21 INFO - Running setup.py (path:/tmp/pip-ODWk23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:21 INFO - Running setup.py (path:/tmp/pip-IHNAD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:21 INFO - Running setup.py (path:/tmp/pip-iyxzlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:21 INFO - Running setup.py (path:/tmp/pip-NLna_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:21 INFO - Running setup.py (path:/tmp/pip-MQ3BDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:21 INFO - Running setup.py (path:/tmp/pip-SaePx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:21 INFO - Running setup.py (path:/tmp/pip-XGUT8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:21 INFO - Running setup.py (path:/tmp/pip-iTqpzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:21 INFO - Running setup.py (path:/tmp/pip-IOXjjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:21 INFO - Running setup.py (path:/tmp/pip-CPA03d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:21 INFO - Running setup.py (path:/tmp/pip-OAb3mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:21 INFO - Running setup.py (path:/tmp/pip-RuQ5aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:21 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)) 02:34:21 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)) 02:34:21 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)) 02:34:21 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)) 02:34:21 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)) 02:34:21 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)) 02:34:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34:23 INFO - Downloading blessings-1.6.tar.gz 02:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:34:23 INFO - Installing collected packages: blessings 02:34:23 INFO - Running setup.py install for blessings 02:34:24 INFO - Successfully installed blessings 02:34:24 INFO - Cleaning up... 02:34:24 INFO - Return code: 0 02:34:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:34:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:24 INFO - Reading from file tmpfile_stdout 02:34:24 INFO - Current package versions: 02:34:24 INFO - argparse == 1.2.1 02:34:24 INFO - blessings == 1.6 02:34:24 INFO - blobuploader == 1.2.4 02:34:24 INFO - docopt == 0.6.1 02:34:24 INFO - functools32 == 3.2.3-2 02:34:24 INFO - jsonschema == 2.5.1 02:34:24 INFO - manifestparser == 1.1 02:34:24 INFO - mozInstall == 1.12 02:34:24 INFO - mozcrash == 0.17 02:34:24 INFO - mozdebug == 0.1 02:34:24 INFO - mozdevice == 0.48 02:34:24 INFO - mozfile == 1.2 02:34:24 INFO - mozhttpd == 0.7 02:34:24 INFO - mozinfo == 0.9 02:34:24 INFO - mozleak == 0.1 02:34:24 INFO - mozlog == 3.3 02:34:24 INFO - moznetwork == 0.27 02:34:24 INFO - mozprocess == 0.23 02:34:24 INFO - mozprofile == 0.28 02:34:24 INFO - mozrunner == 6.12 02:34:24 INFO - mozscreenshot == 0.1 02:34:24 INFO - mozsystemmonitor == 0.3 02:34:24 INFO - moztest == 0.7 02:34:24 INFO - mozversion == 1.4 02:34:24 INFO - psutil == 3.1.1 02:34:24 INFO - requests == 1.2.3 02:34:24 INFO - wsgiref == 0.1.2 02:34:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:24 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 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:24 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 02:34:24 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 02:34:24 INFO - Using env: {'DISPLAY': ':0', 02:34:24 INFO - 'HOME': '/home/cltbld', 02:34:24 INFO - 'LANG': 'en_US.UTF-8', 02:34:24 INFO - 'LANGUAGE': 'en_US:en', 02:34:24 INFO - 'LOGNAME': 'cltbld', 02:34:24 INFO - 'MAIL': '/var/mail/cltbld', 02:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:24 INFO - 'MOZ_NO_REMOTE': '1', 02:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:24 INFO - 'NO_EM_RESTART': '1', 02:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:24 INFO - 'PWD': '/builds/slave/test', 02:34:24 INFO - 'SHELL': '/bin/bash', 02:34:24 INFO - 'SHLVL': '1', 02:34:24 INFO - 'TERM': 'linux', 02:34:24 INFO - 'TMOUT': '86400', 02:34:24 INFO - 'USER': 'cltbld', 02:34:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:24 INFO - '_': '/tools/buildbot/bin/python'} 02:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 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)) 02:34:24 INFO - Cleaning up... 02:34:24 INFO - Return code: 0 02:34:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84018aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1421230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', '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 02:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:34:24 INFO - Using env: {'DISPLAY': ':0', 02:34:24 INFO - 'HOME': '/home/cltbld', 02:34:24 INFO - 'LANG': 'en_US.UTF-8', 02:34:24 INFO - 'LANGUAGE': 'en_US:en', 02:34:24 INFO - 'LOGNAME': 'cltbld', 02:34:24 INFO - 'MAIL': '/var/mail/cltbld', 02:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:24 INFO - 'MOZ_NO_REMOTE': '1', 02:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:24 INFO - 'NO_EM_RESTART': '1', 02:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:24 INFO - 'PWD': '/builds/slave/test', 02:34:24 INFO - 'SHELL': '/bin/bash', 02:34:24 INFO - 'SHLVL': '1', 02:34:24 INFO - 'TERM': 'linux', 02:34:24 INFO - 'TMOUT': '86400', 02:34:24 INFO - 'USER': 'cltbld', 02:34:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:24 INFO - '_': '/tools/buildbot/bin/python'} 02:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:34:24 INFO - Cleaning up... 02:34:24 INFO - Return code: 0 02:34:24 INFO - Running post-action listener: _resource_record_post_action 02:34:24 INFO - Running post-action listener: _start_resource_monitoring 02:34:24 INFO - Starting resource monitoring. 02:34:24 INFO - [mozharness: 2016-08-30 09:34:24.824491Z] Finished create-virtualenv step (success) 02:34:24 INFO - [mozharness: 2016-08-30 09:34:24.824956Z] Running install step. 02:34:24 INFO - Running pre-action listener: _resource_record_pre_action 02:34:24 INFO - Running main action method: install 02:34:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:25 INFO - Reading from file tmpfile_stdout 02:34:25 INFO - Detecting whether we're running mozinstall >=1.0... 02:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:34:25 INFO - Reading from file tmpfile_stdout 02:34:25 INFO - Output received: 02:34:25 INFO - Usage: mozinstall [options] installer 02:34:25 INFO - Options: 02:34:25 INFO - -h, --help show this help message and exit 02:34:25 INFO - -d DEST, --destination=DEST 02:34:25 INFO - Directory to install application into. [default: 02:34:25 INFO - "/builds/slave/test"] 02:34:25 INFO - --app=APP Application being installed. [default: firefox] 02:34:25 INFO - mkdir: /builds/slave/test/build/application 02:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:34:41 INFO - Reading from file tmpfile_stdout 02:34:41 INFO - Output received: 02:34:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:34:41 INFO - Running post-action listener: _resource_record_post_action 02:34:41 INFO - [mozharness: 2016-08-30 09:34:41.258326Z] Finished install step (success) 02:34:41 INFO - [mozharness: 2016-08-30 09:34:41.258608Z] Running run-tests step. 02:34:41 INFO - Running pre-action listener: _resource_record_pre_action 02:34:41 INFO - Running main action method: run_tests 02:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:41 INFO - Python 2.7.3 02:34:41 INFO - Return code: 0 02:34:41 INFO - grabbing minidump binary from tooltool 02:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:41 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 0x141b090>, '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 0x141e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:41 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 02:34:41 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 02:34:41 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 02:34:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:41 INFO - Return code: 0 02:34:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:34:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:34:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:41 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/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:34:41 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/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:34:41 INFO - Using env: {'DISPLAY': ':0', 02:34:41 INFO - 'HOME': '/home/cltbld', 02:34:41 INFO - 'LANG': 'en_US.UTF-8', 02:34:41 INFO - 'LANGUAGE': 'en_US:en', 02:34:41 INFO - 'LOGNAME': 'cltbld', 02:34:41 INFO - 'MAIL': '/var/mail/cltbld', 02:34:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:41 INFO - 'MOZ_NO_REMOTE': '1', 02:34:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:41 INFO - 'NO_EM_RESTART': '1', 02:34:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:41 INFO - 'PWD': '/builds/slave/test', 02:34:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:41 INFO - 'SHELL': '/bin/bash', 02:34:41 INFO - 'SHLVL': '1', 02:34:41 INFO - 'TERM': 'linux', 02:34:41 INFO - 'TMOUT': '86400', 02:34:41 INFO - 'USER': 'cltbld', 02:34:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472549238.871303-838109831', 02:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:41 INFO - '_': '/tools/buildbot/bin/python'} 02:34:41 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/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:34:41 INFO - mozversion application_buildid: 20160830010820 02:34:41 INFO - mozversion application_changeset: bc60cb47882ac16cd4bade1e2d0e2623130f2e9b 02:34:41 INFO - mozversion application_display_name: Nightly 02:34:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:41 INFO - mozversion application_name: Firefox 02:34:41 INFO - mozversion application_remotingname: firefox 02:34:41 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 02:34:41 INFO - mozversion application_vendor: Mozilla 02:34:41 INFO - mozversion application_version: 51.0a1 02:34:41 INFO - mozversion platform_buildid: 20160830010820 02:34:41 INFO - mozversion platform_changeset: bc60cb47882ac16cd4bade1e2d0e2623130f2e9b 02:34:41 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 02:34:41 INFO - mozversion platform_version: 51.0a1 02:34:41 INFO - using testdate: 1472549681 02:34:41 INFO - actual date: 1472549681 02:34:41 INFO - starting webserver on 'localhost:41138' 02:34:41 INFO - SUITE-START | Running 2 tests 02:34:41 INFO - TEST-START | dromaeo_css 02:34:41 INFO - operating with platform_type : linux_ 02:34:41 INFO - Initialising browser for dromaeo_css test... 02:34:41 INFO - TEST-INFO | started process 8873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY33aHS/profile http://localhost:41138/getInfo.html) 02:34:47 INFO - PROCESS | 8873 | __metrics Screen width/height:1600/1200 02:34:47 INFO - PROCESS | 8873 | colorDepth:24 02:34:47 INFO - PROCESS | 8873 | Browser inner width/height: 1024/697 02:34:47 INFO - PROCESS | 8873 | __metrics 02:34:48 ERROR - PROCESS | 8873 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 02:34:49 INFO - TEST-INFO | 8873: exit 0 02:34:49 INFO - Browser initialized. 02:34:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:49 INFO - TEST-INFO | started process 8995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY33aHS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:01 INFO - PROCESS | 8995 | RSS: Main: 195616768 02:35:01 INFO - PROCESS | 8995 | 02:35:51 INFO - PROCESS | 8995 | 1472549751255 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] 02:38:04 INFO - PROCESS | 8995 | Cycle 1(1): loaded http://localhost:41138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41138/tests/dromaeo/cssquery-ext.html) 02:38:05 INFO - PROCESS | 8995 | RSS: Main: 208896000 02:38:05 INFO - PROCESS | 8995 | 02:41:07 INFO - PROCESS | 8995 | Cycle 1(1): loaded http://localhost:41138/tests/dromaeo/cssquery-ext.html (next: http://localhost:41138/tests/dromaeo/cssquery-jquery.html) 02:41:08 INFO - PROCESS | 8995 | RSS: Main: 203075584 02:41:08 INFO - PROCESS | 8995 | 02:44:10 INFO - PROCESS | 8995 | Cycle 1(1): loaded http://localhost:41138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41138/tests/dromaeo/cssquery-mootools.html) 02:44:11 INFO - PROCESS | 8995 | RSS: Main: 199999488 02:44:11 INFO - PROCESS | 8995 | 02:47:13 INFO - PROCESS | 8995 | Cycle 1(1): loaded http://localhost:41138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41138/tests/dromaeo/cssquery-prototype.html) 02:47:13 INFO - PROCESS | 8995 | RSS: Main: 196341760 02:47:13 INFO - PROCESS | 8995 | 02:50:16 INFO - PROCESS | 8995 | Cycle 1(1): loaded http://localhost:41138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41138/tests/dromaeo/cssquery-yui.html) 02:50:17 INFO - PROCESS | 8995 | RSS: Main: 200421376 02:50:17 INFO - PROCESS | 8995 | 02:53:19 INFO - PROCESS | 8995 | Cycle 1(1): loaded http://localhost:41138/tests/dromaeo/cssquery-yui.html (next: http://localhost:41138/tests/dromaeo/cssquery-dojo.html) 02:53:20 INFO - PROCESS | 8995 | RSS: Main: 200056832 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | __start_tp_report 02:53:20 INFO - PROCESS | 8995 | _x_x_mozilla_page_load 02:53:20 INFO - PROCESS | 8995 | _x_x_mozilla_page_load_details 02:53:20 INFO - PROCESS | 8995 | |i|pagename|runs| 02:53:20 INFO - PROCESS | 8995 | |0;dojo.html;2642.062067965872;2668.359593697512;2669.145873320538;2696.245051385613;2702.6081218223358;4635.443746750386;4730.432348118226;4796.496367881375;4815.0610630926985;4884.169691152504;4744.525547445253;4746.382970213876;4775.068861572004;4807.254875494304;4841.927371089437;4351;4435.289738180916;4435.489918659363;4549.11292298002;4554.066416384633;4452.866414007569;4505.954940450602;4524.886877828064;4536.138133754593;4538.160440318552;4281.636060934824;4349.478062632473;4367.934480982788;4404.66964977628;4462.665300102472;4354.738715677038;4356.6950313477755;4375.16871794358;4461.397711308964;4465.330200469955;4384.605385515319;4393.928064009578;4396.252637051709;4434.024514606781;4449.755263460508;4652.604528615038;4704.458987216445;4735.810567577293;4805.927911081301;4812.711237325771;5073.594112471031;5077.923831142536;5083.567896728782;5086.160783470723;5116.539511443988;5025.447200807908;5059.367579052619;5066.873328166826;5080.923786143211;5117.7185254810975;4669.556392142741;4717.9292310615365;4736.384270044872;4742.264948932921;4757.619390448755;5187.559057480081;5209.166533354645;5225.399079105951;5228.398734145622;5270.683758974474;5006.824761133415;5018.322526458955;5019.322391477177;5026.89946201074;5081.466446023188;4945.876353091129;5052.520010598987;5056.82301119459;5075.543201111917;5090.363704536933;5054.7472626368535;5060.822871199491;5064.670796398223;5071.290019397287;5071.822486212965;5028.748562571856;5037.269595908573;5038.193888977746;5039.118154323052;5095.133827249377;4275.273203555403;4376.343548467756;4377.343398490252;4395.670324725658;4454.1982443159895;3840.2895464339185;3840.5967373425947;3844.6539811417106;3891.6497515223764;3894.9805250973563;4452.30989196675;4462.6876118672035;4462.732236065846;4473.5526447355005;4515.706479078849;4969.3291405659775;5080.958403527268;5103.948960510422;5123.257127716461;5146.073706732749;4426.44669416323;4444.28891377378;4468.017036252019;4505.346724724896;4510.413646225969;4663.183942809995;4683.414573178353;4683.765811709401;4697.4832768395445;4742.52574742523;4649.279766486422;4725.078609671081;4759.690620109682;4768.356271903249;4803.975980120007;5095.617828662791;5096.108181068373;5101.056304583664;5108.131617624938;5175.4565770593545;4735.360726301905;4769.713817170981;4780.593649539828;4782;4828.4688684244;4929.088118698052;4995.725235112103;5023.547880690755;5041.344625198701;5065.29085927963;5130.050940576006;5130.589552835839;5134.76893539799;5137.5889928806355;5169.793208271627;4970.502949705001;4976.2539783261955;4980.950190498049;4989.351384320015;5048.873778155576;4837.467878533429;4945.62907781925;4956.454789973172;4970.279309500174;5028.748562571784;4780.832670856643;4950.777215025405;4966.255061740768;4967.329410529533;5018.272350509083;5094.745262736774;5103.974480127576;5104.438511763628;5109.182530795055;5157.948420515897;4685.835995740133;4763.499832517675;4782.0914026334885;4797.592204662643;4969.4782047884455 02:53:20 INFO - PROCESS | 8995 | |1;ext.html;536.8792021795097;549.535642382187;558.2240685447229;564.3820017081296;565.5532129617602;34431.31137377251;38720;38731.80634096826;38738.806305968465;38765.22469550614;38992.41511377331;39558.208835823265;39696.40455393164;39711.80144099276;39929.600703992954;7646.502977306485;7843.137254901956;7852.725154619589;7858.017747781528;7866.0560732711865;7659.119201291839;7743.419243556727;7764.223577642247;7772;7779.9222007780045;7663.080430348338;7733.497322674037;7735.419843511731;7739.57432341221;7787.182345853689;7671.156172820985;7698.807529811744;7703.152653208114;7728.381729461629;7737.729179478748;7644.426667999866;7708.768736937901;7710.306072453506;7769.494982826155;7775.4168437367425;36052;36371.27257454836;36389.45415818765;36398.8180059098;36485.63514364849;2955.246412164906;2957.216337670519;2957.275467510474;3105.596272484585;3313.1717070732316;28241.576376354373;28718.712812871814;28988.855055724798;29260.41479170426;30017;2975.36029753604;3018.8792448302042;3061.0971011959705;3071.370369074357;3271.5419841222247;238067;239050;239055;240246;240763;30673.233169170948;52516;52533.21200182;52651;52713;31383.529247061313;32680.182995424828;32963;33152.50271245885;33412.83293583565;13457.31783527059;13538.458461661423;13582.93208533951;13585.456581736818;13611.25138117413;10491.895081049091;10533.789324213472;10559.841602375971;10567.471626418648;10590.352411897025;7648.655810488542;7747.341475974493;7757.185495523002;7775.1447340792465;7807.609619519001;2988.417258634589;3092.2424006118645;3097.3650401667605;3131.906042818719;3138.3095718941795;797.6211299632744;858.3690987124459;890.1143362354499;969.4377261188494;970.8446648536342;26267.21198364052;26885.596716049276;27218.72781272162;28293;28401.28996775097;947.5357075033185;964.3731574476647;1030.1141018723893;1037.4345981440133;1075.983860242097;14715.411383544539;14741.852581474048;14784.408623654934;14856.331465084097;14911.776323355158;368797;370874;370944;373602;376083;48946;49631;49636.25545616819;49654.75172624186;49678.751606241734;1131.603938621476;1179.262960649594;1188.8751681073536;1208.2448469706433;1209.29256385014;25544.361390965376;26030.609540856523;27100.457990839677;27828.86085569559;27842.721572784012;41268.174636507705;41828.790856045525;41942.370864436445;41987.79006105072;42028.57971420369;334511;336287;338414;339955;340734;25161.87419062893;25532.872335638203;25565.872170639028;25568.744312556635;25579.616305755055;40882.59117408788;41293.58706412897;41500.58499415088;41525.58474415217;42491.36262955996;34731;35524;35665.46501802527;35710.4643430354;36394.27211455809;34767.82616087005;34861;35034.474482882266;35060.12349691278;35287;27148.72851271462;34274.14314642154;34644.82677586596;34947.30105397929;35334.29331413409;30109;31324.53013204758;31914.36171276608;32010.839945800122;32365;24654.383640409134;24709.752902470744;25213.243602691215;25376.365590860376;25763.742362576133 02:53:20 INFO - PROCESS | 8995 | |2;jquery.html;333.1504663109071;342.14975785173823;357.5441312326783;362.31884057971;364.775662967275;15833.524994250161;15996.440124595641;17163.141842907837;17230.913845430787;17420.65158696825;15362.769558456604;16336.34654613817;16518.091504967222;16537.91731041343;16541.751873721874;4708.9529104708945;5022.84931452057;5056.039352523009;5059.519345662175;5060.54455099041;4996.675216110941;5054.342935418391;5065.518775716319;5066.341375621182;5084.237364395333;4996.600271978251;5153.922691159635;5410.08028635131;5455.018096742585;5534.944650553483;5400.545449096402;5463.535599474049;5483.820978489604;5494.2857428534435;5498.615096943216;5244.449332820037;5300.681959082467;5308.6549374290935;5325.520703136697;5333.333333333333;11995.820062699066;12145;12149.757004859854;18861.622767544708;19577.119029643556;1891.4609336339215;1952.3069310394746;1978.307592342683;2110.807393822485;2292.106078629336;8927.37508374414;8933.330000250007;8936.240419564345;9465.574049167804;9513.857292140623;1603.1503303249297;1711.5721069732567;1722.345508706696;1738.322054398773;1766.5406994181476;70777;70828.6458567709;70904.6454767728;71459.64270178616;71545.64227178883;9757.512124393752;9793.608255669693;9969.152622027208;10043.799124017478;10073.395596264247;13501.797473037912;13540;13597.524086657117;13613.455461781417;13649.795253071212;6796.184457864989;7062.364387205176;7104.893426598605;7341.375983041395;7349.522281051714;6987.9301206987275;7033.296670332926;7118.501704880712;7166.641667916583;7229.8554028919125;4133.91732165361;4231.2806822839575;4245.532991370947;4281.272183728774;4396.4284642996845;1789.6599646067466;1842.8065053169491;1855.072463768116;1868.3460788723837;1882.397632757532;761.432732614195;818.9713360032489;854.974350769478;933.4679232837218;946.7491114854569;16527.33890644361;16692.415765448393;17248.223829927683;17507;17679.646407071785;850.9320802392957;862.5687156421789;871.6861929705301;894.2845723421237;900.9324300677475;9098.79806493439;9496.240300775922;9725;9795.9020409795;9800.26498012652;356994;363506;363678.99531051563;365520;377915;64547;73007.63496182485;76517.6174119137;77918.6104069476;80244;799.2367289238879;846.2891171415918;846.9449485783405;847.9660813567635;848.3467729847982;15135.318910648826;15474.381024759334;15769.842301576837;15782.842171578597;16279.267432965307;37432.625673742914;37914.43128353022;37946.810265948494;38038.80980595079;39576.2084758309;52637.47362526326;53231.46768532265;54303.72848135892;54535.454645453035;54552;10906.291091079054;10919.290246133976;11117.944410277896;11418.828717569077;11523.193376463567;12289.631311060682;12921;12930.935345323589;13135.883449906865;13269.800952985519;10014;11189.104871610089;11224.382658953837;11396.48715807774;11443.370614616277;11275.718107047389;11376.55404088092;11423.942880285545;11544.307341559534;11904.523819047141;11121.610743623934;11186.608468703556;11285;11488.368139752394;11643.941780291045;11642.53429862796;11700.765984680089;11883;11931.582394616147;12178.57374991871;11314.60398886068;11377.203595748219;11418.143639226924;11589.362585057566;11832 02:53:20 INFO - PROCESS | 8995 | |3;mootools.html;1325.622197673663;1360.2518614761882;1403.7332906747718;1610.5168449465157;1644.3587001069577;6907.0675458813175;7412.184659687437;7620.237976202391;8008.3593312535;8060.032796064465;7655.387568994467;7928.563928983904;7936.246056624625;7936.880946785803;7938.245866642674;2164.2641501889357;2200.878951657658;2201.966970495444;2202.2292197730744;2206.293985924505;2099.674550444676;2129.6805479178092;2164.675298705199;2166.8483206175574;2169.045619927235;2128.1487405037956;2140.475583482041;2150.3441450357636;2154.633712268918;2156.8490205685607;2080.6046851098317;2080.8127268545904;2092.393205970267;2093.194120263694;2098.4544018555134;2037.8165965063067;2074.408793493847;2084.3642688979853;2087.039961617658;2088.853780235384;7536.660850261751;7600.619969001527;7847.411444141712;7903.407244456689;7905.96047019767;4225.19721252961;4356.302991521373;4370.606645401929;4374.5844144806515;4394.780260986938;2833.759130473912;2955.5123404638207;2958.3047983724023;2991.9401611967637;3000.144958686764;963.513425720014;986.442659897163;998.2213873178932;999.4053538144792;1005.4419797012655;10704.732381690443;10727.141828653766;10744;10776.73058173544;10798.136149108132;3930.21395720857;4011.8194681239415;4226.535081141072;4259.212045771542;4259.531451540328;9140.177384035469;9201.217896478875;9214.539273036322;9252.398594091363;9269.536523173814;4543.273076307775;4564.771761411983;4570.520095390003;4572.177008138567;4587;3683.244934788362;3914.4324073009825;4013.7792421417103;4196.874093777192;4218.599233072853;3610.476480910306;3624.9700167906058;3627.6553727395853;3645.781253124821;3651.72612054097;1171.8769529199483;1173.6831055614937;1179.3572502985894;1184.538030168235;1214.9976269577635;763.282514436428;779.4582764978286;782.7456076775071;787.7597332813432;798.1260519730886;4670.509596492319;4760.690555113906;4795.352627395257;4850.563449289581;4924.532169443897;395.12676983865975;412.04405778593974;413.3551659411328;414.48810718762303;415.82327510807784;3293.7035666790102;3332.274838248716;3349.6315405305395;3369.7809642373168;3383.204946837491;9256;9441.811163776685;9592.808143837225;9676.70969870905;9727;9537.141657250742;9548.856767148498;9549.331546791796;9631.518424078908;9642.132208101164;7140.285971402922;7218.989341492195;7302.525335853153;7321.487495875238;7380.261973802577;4497.640188784824;4503.594676479132;4984.277279794482;5105.2086926526445;5194.091034069098;8274.338052955869;8305.335573154254;8466.238038576557;8788.736337909873;8940.597673104596;8449.45078569891;8496.1079086695;8506.702265420681;8594.527300998256;8743;5831.7375718093635;6393.904091438725;6550.7707230246715;6653.234877989094;6839.1451068616425;7403.629818508945;7484.214157513383;7494.662740176815;7506.587137707478;7514.849703006019;6550.082988381535;6634.104395906684;6672.332766723289;6793.218779840382;6815;6728.360805723449;6817.386435220854;6904.378605925491;6910.619915904674;6991.825204369931;5905.793297234748;5962.433568810956;6054.9091763624465;6055.2430946131735;6055.969720151371;4204.096119334357;4245.426867372865;4276.615104640598;4298.398224248545;4330.133973205308;4399.472063352418;4400.44994375703;4407.801648925742;4414.227510185769;4421.579949904753 02:53:20 INFO - PROCESS | 8995 | |4;prototype.html;296.6781042568813;299.51030065842343;301.502520840613;305.8088694565896;307.1691075640393;4936.506349365066;4945.975270123648;4966.478519755427;4971.68595883228;4975.701457912523;4898.0897449994445;4899.779509922053;4901.460839307673;4906.607471402288;4915.336429582015;3647.3070116677877;3697.9815100924457;3787.4508196311517;3805.315043292206;3811.2568049230413;3801.182745709672;3810;3821.9808900955454;3836.712246581518;3848.942265866014;3830.6743926766258;3835.539735231776;3836.386178211487;3855.961440385602;3877.6316249956208;3531.858725650971;3749.9125253676402;3838.673712734421;3841.9242612068665;3864.782593483072;3327.434336162858;3330.766846320734;3338.1487720631326;3341.6800363856382;3341.6992470677756;4777;4799.424069111729;4800.855974320776;4803.543663351976;4803.639727020487;4346.521882592912;4348.673849461272;4355.909163601457;4356.847510337123;4377.102693947733;4988.904660042791;5124.205748109049;5128.435872054071;5135.3324067870935;5140.254663073833;3587.1390866192187;3591.515145455356;3604.387254166798;3616.6202548732267;3624.6375362463805;5343.679379237219;5353.250544923714;5388.413561490467;5396.785723212285;5397.379301380313;3621.0947263184203;3678.5585729712607;3700.648438398348;3705.3515634763808;3735.533058367704;3754.436834474796;3758.699304055669;3763.2285381496727;3775;3775.3581891078584;4327.891802704958;4331.350297455344;4347.152305300499;4351.477822661301;4355.237833379146;5012.373453318335;5091.392289977576;5159.690418574897;5176.1459359206065;5181.248718935733;1291.14139097501;1315.355475816843;1315.5461365828965;1318.8615195404536;1321.378951892609;803.4616806739499;828.3828547731978;836.2348451167236;838.7986883148122;842.9620667069996;4340.717853339523;4449.621782148489;4586.793594288265;4592.678512504092;4594.450080205518;5301.1783173608155;5343.759530821122;5353.839384818461;5354.839354819362;5357.892842143136;4595.356650068993;4613.331066995334;4616.215243408628;4621.30680397943;4633.328167415706;2680.182544324;2787.456445993012;2818.844963527026;2821.1818572614125;2832.22113918674;4898.412190537087;4934.827281045218;4973.254011898244;4999.850034492015;5014.749262536859;5138.922916156261;5409.513143817076;5412.675239485565;5428.45715428454;5436.510714035756;4974.676646017997;4975.477574854661;4990;4996.350474438373;5002.399712034507;5281;5347.866303342447;5363.865903352447;5369.812056578001;5377.27406800077;4971.1797553403285;5189.091908916;5200.947990520198;5205.947940520698;5216.634835561475;4986.15235409974;4990.8752281193265;4996.775145118406;5008.874778130576;5021.6735912165595;3716.572594151599;3755.1926335837925;3771.283456143324;3776.9802153418973;3786.5077539920735;5115.616328775282;5275.261463395204;5385.838424847261;5398.058058358126;5420.186971954238;5154.845354639367;5164.509371609691;5171.3535808024;5171.81898633546;5175.792968281226;5171.92242116361;5190.97404512975;5207.4271830097905;5207.71357575337;5209.531142197069;5021.974890125526;5108.770105345343;5113.8977220454635;5116.079105760999;5147.6139289554185;4969.180085285887;5028.2960385546785;5196.350456192976;5203.424304969065;5215.817446389358;5033.748312584283;5037.697738135724;5056.266841307916;5060.1903695408555;5061.721605311596 02:53:20 INFO - PROCESS | 8995 | |5;yui.html;523.2308506495451;590.4390828712724;607.1681795939563;612.3019757476475;643.594535442671;11467.254628449145;12234;12608.747825043516;12661.49354025839;12685;12303.753924921497;12391.25652460853;12423.31671758053;12445.875541244584;12474.688132796684;592.7095723095673;713.0587624335878;728.8760910645177;729.6315360742817;729.7810656802965;717.5694583250034;722.7542635503928;722.9385502232317;741.6032422653881;748.3638906929122;780.6526095887332;783.5298820707559;783.7766236622564;784.1178673991759;785.2932360875201;778.8091917480197;778.9143194248628;780.2821404307994;781.281221276427;782.4405550031726;566.1818672018934;571.1746526269542;572.6220694341714;574.0528128587822;574.4887050525036;12685.556005539762;12700.237985720887;12770.680732981657;12777.29724865132;12792.168509046975;11991.64025079249;12132.090093243041;12251.877481225163;12298.815517767242;12700.428480718298;10221.802267754112;10509.842352364643;10513.579456821719;10560;10649;3126.3590963852357;3172.191091271734;3177.5551422800827;3252.8777571737714;3262.706356427933;63999;65199.348006520275;67147.3285267146;67733.66133169353;67867.9999999995;8577.571121443903;8678.862291754313;9581.760455988657;10037;10303.124234440007;19811.306604268782;20704.48238794042;20741.792582073987;20765.377038688865;20891.477713057295;7048.753293634698;7117.501774875813;7167.92832071683;7183.389411899942;7183.928160718326;3617.3488772020764;3651.379265524867;3657.6342365763744;3672.192117734094;3716.8141592920247;2931.3257950671464;3018.818870867711;3042.3763128558594;3044.1476386611785;3052.0080973683644;479.61870313101167;479.78169932680544;485.01057842002626;486.19534670121004;497.1895809830026;509.3251441839577;575.666113654088;577.4225774225774;595.3837777899939;598.3986093975527;7192.92807071933;7393.926060739432;7622.428317876182;7725.922740772633;7914.366850651934;544.6051612580848;548.4022415566972;555.6666000399728;611.703323887914;621.2513920725515;3517.50754894315;3747.4940882980995;3794.1083845296334;3828.253490569368;3865.9806700966315;84337;93013;93628;95162;97707;45448.54551454443;48706.75646621744;55758.72120639452;65763;80140;68615;71453.642731786;71769;73281;73337.63331183417;7282.817929551804;7456.66445009965;7508.6996520140765;7618.238176182337;7690.6539205737;31612.209694757814;38255.04362390962;38732.2253554933;41835.372469412374;45651.771741141085;60969.695151523956;64581;65280;75923;83820.16179838123;10978.670639880816;11216.158788090763;11244.368107933058;11368.943155284502;11621.941890290833;11741.41292935367;11982.520699172284;12081.697957551132;12352.938235308766;12430.875691242973;10641.148708103488;10883.945580272048;10931.83602245983;11045.116390688565;11203.271787333797;11204.66386008421;11248.26886252391;11301.71745706364;11311.490982905954;11584.826227606762;10763.677089687322;10910.345379277269;10976.341419514854;11003.834942476029;11167.49746261404;8383.538905360263;8582.699605513777;8678.52268125234;8729.3889427742;8915.465072095694;8735.694250701195;8775.692850750449;9245;9286.860697089414;9475.763105922131 02:53:20 INFO - PROCESS | 8995 | __end_tp_report 02:53:20 INFO - PROCESS | 8995 | __start_cc_report 02:53:20 INFO - PROCESS | 8995 | _x_x_mozilla_cycle_collect,364 02:53:20 INFO - PROCESS | 8995 | __end_cc_report 02:53:20 INFO - PROCESS | 8995 | __startTimestamp1472550800111__endTimestamp 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | ------- Summary: start ------- 02:53:20 INFO - PROCESS | 8995 | Number of tests: 6 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | [#0] dojo.html Cycles:165 Average:4726.40 Median:4803.98 stddev:477.77 (9.9%) stddev-sans-first:450.39 02:53:20 INFO - PROCESS | 8995 | Values: 2642.1 2668.4 2669.1 2696.2 2702.6 4635.4 4730.4 4796.5 4815.1 4884.2 4744.5 4746.4 4775.1 4807.3 4841.9 4351.0 4435.3 4435.5 4549.1 4554.1 4452.9 4506.0 4524.9 4536.1 4538.2 4281.6 4349.5 4367.9 4404.7 4462.7 4354.7 4356.7 4375.2 4461.4 4465.3 4384.6 4393.9 4396.3 4434.0 4449.8 4652.6 4704.5 4735.8 4805.9 4812.7 5073.6 5077.9 5083.6 5086.2 5116.5 5025.4 5059.4 5066.9 5080.9 5117.7 4669.6 4717.9 4736.4 4742.3 4757.6 5187.6 5209.2 5225.4 5228.4 5270.7 5006.8 5018.3 5019.3 5026.9 5081.5 4945.9 5052.5 5056.8 5075.5 5090.4 5054.7 5060.8 5064.7 5071.3 5071.8 5028.7 5037.3 5038.2 5039.1 5095.1 4275.3 4376.3 4377.3 4395.7 4454.2 3840.3 3840.6 3844.7 3891.6 3895.0 4452.3 4462.7 4462.7 4473.6 4515.7 4969.3 5081.0 5103.9 5123.3 5146.1 4426.4 4444.3 4468.0 4505.3 4510.4 4663.2 4683.4 4683.8 4697.5 4742.5 4649.3 4725.1 4759.7 4768.4 4804.0 5095.6 5096.1 5101.1 5108.1 5175.5 4735.4 4769.7 4780.6 4782.0 4828.5 4929.1 4995.7 5023.5 5041.3 5065.3 5130.1 5130.6 5134.8 5137.6 5169.8 4970.5 4976.3 4981.0 4989.4 5048.9 4837.5 4945.6 4956.5 4970.3 5028.7 4780.8 4950.8 4966.3 4967.3 5018.3 5094.7 5104.0 5104.4 5109.2 5157.9 4685.8 4763.5 4782.1 4797.6 4969.5 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | [#1] ext.html Cycles:180 Average:45685.71 Median:34904.15 stddev:84842.55 (243.1%) stddev-sans-first:85012.84 02:53:20 INFO - PROCESS | 8995 | Values: 536.9 549.5 558.2 564.4 565.6 34431.3 38720.0 38731.8 38738.8 38765.2 38992.4 39558.2 39696.4 39711.8 39929.6 7646.5 7843.1 7852.7 7858.0 7866.1 7659.1 7743.4 7764.2 7772.0 7779.9 7663.1 7733.5 7735.4 7739.6 7787.2 7671.2 7698.8 7703.2 7728.4 7737.7 7644.4 7708.8 7710.3 7769.5 7775.4 36052.0 36371.3 36389.5 36398.8 36485.6 2955.2 2957.2 2957.3 3105.6 3313.2 28241.6 28718.7 28988.9 29260.4 30017.0 2975.4 3018.9 3061.1 3071.4 3271.5 238067.0 239050.0 239055.0 240246.0 240763.0 30673.2 52516.0 52533.2 52651.0 52713.0 31383.5 32680.2 32963.0 33152.5 33412.8 13457.3 13538.5 13582.9 13585.5 13611.3 10491.9 10533.8 10559.8 10567.5 10590.4 7648.7 7747.3 7757.2 7775.1 7807.6 2988.4 3092.2 3097.4 3131.9 3138.3 797.6 858.4 890.1 969.4 970.8 26267.2 26885.6 27218.7 28293.0 28401.3 947.5 964.4 1030.1 1037.4 1076.0 14715.4 14741.9 14784.4 14856.3 14911.8 368797.0 370874.0 370944.0 373602.0 376083.0 48946.0 49631.0 49636.3 49654.8 49678.8 1131.6 1179.3 1188.9 1208.2 1209.3 25544.4 26030.6 27100.5 27828.9 27842.7 41268.2 41828.8 41942.4 41987.8 42028.6 334511.0 336287.0 338414.0 339955.0 340734.0 25161.9 25532.9 25565.9 25568.7 25579.6 40882.6 41293.6 41500.6 41525.6 42491.4 34731.0 35524.0 35665.5 35710.5 36394.3 34767.8 34861.0 35034.5 35060.1 35287.0 27148.7 34274.1 34644.8 34947.3 35334.3 30109.0 31324.5 31914.4 32010.8 32365.0 24654.4 24709.8 25213.2 25376.4 25763.7 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | [#2] jquery.html Cycles:180 Average:23905.89 Median:201476.31 stddev:60506.27 (30.0%) stddev-sans-first:60650.12 02:53:20 INFO - PROCESS | 8995 | Values: 333.2 342.1 357.5 362.3 364.8 15833.5 15996.4 17163.1 17230.9 17420.7 15362.8 16336.3 16518.1 16537.9 16541.8 4709.0 5022.8 5056.0 5059.5 5060.5 4996.7 5054.3 5065.5 5066.3 5084.2 4996.6 5153.9 5410.1 5455.0 5534.9 5400.5 5463.5 5483.8 5494.3 5498.6 5244.4 5300.7 5308.7 5325.5 5333.3 11995.8 12145.0 12149.8 18861.6 19577.1 1891.5 1952.3 1978.3 2110.8 2292.1 8927.4 8933.3 8936.2 9465.6 9513.9 1603.2 1711.6 1722.3 1738.3 1766.5 70777.0 70828.6 70904.6 71459.6 71545.6 9757.5 9793.6 9969.2 10043.8 10073.4 13501.8 13540.0 13597.5 13613.5 13649.8 6796.2 7062.4 7104.9 7341.4 7349.5 6987.9 7033.3 7118.5 7166.6 7229.9 4133.9 4231.3 4245.5 4281.3 4396.4 1789.7 1842.8 1855.1 1868.3 1882.4 761.4 819.0 855.0 933.5 946.7 16527.3 16692.4 17248.2 17507.0 17679.6 850.9 862.6 871.7 894.3 900.9 9098.8 9496.2 9725.0 9795.9 9800.3 356994.0 363506.0 363679.0 365520.0 377915.0 64547.0 73007.6 76517.6 77918.6 80244.0 799.2 846.3 846.9 848.0 848.3 15135.3 15474.4 15769.8 15782.8 16279.3 37432.6 37914.4 37946.8 38038.8 39576.2 52637.5 53231.5 54303.7 54535.5 54552.0 10906.3 10919.3 11117.9 11418.8 11523.2 12289.6 12921.0 12930.9 13135.9 13269.8 10014.0 11189.1 11224.4 11396.5 11443.4 11275.7 11376.6 11423.9 11544.3 11904.5 11121.6 11186.6 11285.0 11488.4 11643.9 11642.5 11700.8 11883.0 11931.6 12178.6 11314.6 11377.2 11418.1 11589.4 11832.0 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | [#3] mootools.html Cycles:180 Average:5028.37 Median:4571.35 stddev:2880.77 (63.0%) stddev-sans-first:2875.41 02:53:20 INFO - PROCESS | 8995 | Values: 1325.6 1360.3 1403.7 1610.5 1644.4 6907.1 7412.2 7620.2 8008.4 8060.0 7655.4 7928.6 7936.2 7936.9 7938.2 2164.3 2200.9 2202.0 2202.2 2206.3 2099.7 2129.7 2164.7 2166.8 2169.0 2128.1 2140.5 2150.3 2154.6 2156.8 2080.6 2080.8 2092.4 2093.2 2098.5 2037.8 2074.4 2084.4 2087.0 2088.9 7536.7 7600.6 7847.4 7903.4 7906.0 4225.2 4356.3 4370.6 4374.6 4394.8 2833.8 2955.5 2958.3 2991.9 3000.1 963.5 986.4 998.2 999.4 1005.4 10704.7 10727.1 10744.0 10776.7 10798.1 3930.2 4011.8 4226.5 4259.2 4259.5 9140.2 9201.2 9214.5 9252.4 9269.5 4543.3 4564.8 4570.5 4572.2 4587.0 3683.2 3914.4 4013.8 4196.9 4218.6 3610.5 3625.0 3627.7 3645.8 3651.7 1171.9 1173.7 1179.4 1184.5 1215.0 763.3 779.5 782.7 787.8 798.1 4670.5 4760.7 4795.4 4850.6 4924.5 395.1 412.0 413.4 414.5 415.8 3293.7 3332.3 3349.6 3369.8 3383.2 9256.0 9441.8 9592.8 9676.7 9727.0 9537.1 9548.9 9549.3 9631.5 9642.1 7140.3 7219.0 7302.5 7321.5 7380.3 4497.6 4503.6 4984.3 5105.2 5194.1 8274.3 8305.3 8466.2 8788.7 8940.6 8449.5 8496.1 8506.7 8594.5 8743.0 5831.7 6393.9 6550.8 6653.2 6839.1 7403.6 7484.2 7494.7 7506.6 7514.8 6550.1 6634.1 6672.3 6793.2 6815.0 6728.4 6817.4 6904.4 6910.6 6991.8 5905.8 5962.4 6054.9 6055.2 6056.0 4204.1 4245.4 4276.6 4298.4 4330.1 4399.5 4400.4 4407.8 4414.2 4421.6 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | [#4] prototype.html Cycles:180 Average:4271.95 Median:4925.08 stddev:1254.08 (25.5%) stddev-sans-first:1221.58 02:53:20 INFO - PROCESS | 8995 | Values: 296.7 299.5 301.5 305.8 307.2 4936.5 4946.0 4966.5 4971.7 4975.7 4898.1 4899.8 4901.5 4906.6 4915.3 3647.3 3698.0 3787.5 3805.3 3811.3 3801.2 3810.0 3822.0 3836.7 3848.9 3830.7 3835.5 3836.4 3856.0 3877.6 3531.9 3749.9 3838.7 3841.9 3864.8 3327.4 3330.8 3338.1 3341.7 3341.7 4777.0 4799.4 4800.9 4803.5 4803.6 4346.5 4348.7 4355.9 4356.8 4377.1 4988.9 5124.2 5128.4 5135.3 5140.3 3587.1 3591.5 3604.4 3616.6 3624.6 5343.7 5353.3 5388.4 5396.8 5397.4 3621.1 3678.6 3700.6 3705.4 3735.5 3754.4 3758.7 3763.2 3775.0 3775.4 4327.9 4331.4 4347.2 4351.5 4355.2 5012.4 5091.4 5159.7 5176.1 5181.2 1291.1 1315.4 1315.5 1318.9 1321.4 803.5 828.4 836.2 838.8 843.0 4340.7 4449.6 4586.8 4592.7 4594.5 5301.2 5343.8 5353.8 5354.8 5357.9 4595.4 4613.3 4616.2 4621.3 4633.3 2680.2 2787.5 2818.8 2821.2 2832.2 4898.4 4934.8 4973.3 4999.9 5014.7 5138.9 5409.5 5412.7 5428.5 5436.5 4974.7 4975.5 4990.0 4996.4 5002.4 5281.0 5347.9 5363.9 5369.8 5377.3 4971.2 5189.1 5200.9 5205.9 5216.6 4986.2 4990.9 4996.8 5008.9 5021.7 3716.6 3755.2 3771.3 3777.0 3786.5 5115.6 5275.3 5385.8 5398.1 5420.2 5154.8 5164.5 5171.4 5171.8 5175.8 5171.9 5191.0 5207.4 5207.7 5209.5 5022.0 5108.8 5113.9 5116.1 5147.6 4969.2 5028.3 5196.4 5203.4 5215.8 5033.7 5037.7 5056.3 5060.2 5061.7 02:53:20 INFO - PROCESS | 8995 | 02:53:20 INFO - PROCESS | 8995 | [#5] yui.html Cycles:180 Average:16823.90 Median:533.92 stddev:23903.09 (4476.9%) stddev-sans-first:23938.81 02:53:20 INFO - PROCESS | 8995 | Values: 523.2 590.4 607.2 612.3 643.6 11467.3 12234.0 12608.7 12661.5 12685.0 12303.8 12391.3 12423.3 12445.9 12474.7 592.7 713.1 728.9 729.6 729.8 717.6 722.8 722.9 741.6 748.4 780.7 783.5 783.8 784.1 785.3 778.8 778.9 780.3 781.3 782.4 566.2 571.2 572.6 574.1 574.5 12685.6 12700.2 12770.7 12777.3 12792.2 11991.6 12132.1 12251.9 12298.8 12700.4 10221.8 10509.8 10513.6 10560.0 10649.0 3126.4 3172.2 3177.6 3252.9 3262.7 63999.0 65199.3 67147.3 67733.7 67868.0 8577.6 8678.9 9581.8 10037.0 10303.1 19811.3 20704.5 20741.8 20765.4 20891.5 7048.8 7117.5 7167.9 7183.4 7183.9 3617.3 3651.4 3657.6 3672.2 3716.8 2931.3 3018.8 3042.4 3044.1 3052.0 479.6 479.8 485.0 486.2 497.2 509.3 575.7 577.4 595.4 598.4 7192.9 7393.9 7622.4 7725.9 7914.4 544.6 548.4 555.7 611.7 621.3 3517.5 3747.5 3794.1 3828.3 3866.0 84337.0 93013.0 93628.0 95162.0 97707.0 45448.5 48706.8 55758.7 65763.0 80140.0 68615.0 71453.6 71769.0 73281.0 73337.6 7282.8 7456.7 7508.7 7618.2 7690.7 31612.2 38255.0 38732.2 41835.4 45651.8 60969.7 64581.0 65280.0 75923.0 83820.2 10978.7 11216.2 11244.4 11368.9 11621.9 11741.4 11982.5 12081.7 12352.9 12430.9 10641.1 10883.9 10931.8 11045.1 11203.3 11204.7 11248.3 11301.7 11311.5 11584.8 10763.7 10910.3 10976.3 11003.8 11167.5 8383.5 8582.7 8678.5 8729.4 8915.5 8735.7 8775.7 9245.0 9286.9 9475.8 02:53:20 INFO - PROCESS | 8995 | -------- Summary: end -------- 02:53:20 INFO - PROCESS | 8995 | 02:53:21 INFO - TEST-INFO | 8995: exit 0 02:53:21 INFO - TEST-OK | dromaeo_css | took 1119640ms 02:53:21 INFO - TEST-START | kraken 02:53:21 INFO - operating with platform_type : linux_ 02:53:21 INFO - Initialising browser for kraken test... 02:53:21 INFO - TEST-INFO | started process 9345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDKaKeN/profile http://localhost:41138/getInfo.html) 02:53:26 INFO - PROCESS | 9345 | __metrics Screen width/height:1600/1200 02:53:26 INFO - PROCESS | 9345 | colorDepth:24 02:53:26 INFO - PROCESS | 9345 | Browser inner width/height: 1024/697 02:53:26 INFO - PROCESS | 9345 | __metrics 02:53:27 ERROR - PROCESS | 9345 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 02:53:28 INFO - TEST-INFO | 9345: exit 0 02:53:28 INFO - Browser initialized. 02:53:28 INFO - Running cycle 1/1 for kraken test... 02:53:28 INFO - TEST-INFO | started process 9465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDKaKeN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:41 INFO - PROCESS | 9465 | RSS: Main: 195477504 02:53:41 INFO - PROCESS | 9465 | 02:53:44 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41138/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:45 INFO - PROCESS | 9465 | RSS: Main: 208068608 02:53:45 INFO - PROCESS | 9465 | 02:53:47 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41138/tests/kraken/driver.html?testName=audio-dft) 02:53:48 INFO - PROCESS | 9465 | RSS: Main: 207089664 02:53:48 INFO - PROCESS | 9465 | 02:53:51 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41138/tests/kraken/driver.html?testName=audio-fft) 02:53:52 INFO - PROCESS | 9465 | RSS: Main: 200445952 02:53:52 INFO - PROCESS | 9465 | 02:53:54 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41138/tests/kraken/driver.html?testName=audio-oscillator) 02:53:55 INFO - PROCESS | 9465 | RSS: Main: 201183232 02:53:55 INFO - PROCESS | 9465 | 02:53:57 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:57 INFO - PROCESS | 9465 | RSS: Main: 201256960 02:53:57 INFO - PROCESS | 9465 | 02:54:01 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41138/tests/kraken/driver.html?testName=imaging-darkroom) 02:54:01 INFO - PROCESS | 9465 | RSS: Main: 201392128 02:54:01 INFO - PROCESS | 9465 | 02:54:05 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41138/tests/kraken/driver.html?testName=imaging-desaturate) 02:54:05 INFO - PROCESS | 9465 | RSS: Main: 197599232 02:54:05 INFO - PROCESS | 9465 | 02:54:08 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41138/tests/kraken/driver.html?testName=json-parse-financial) 02:54:09 INFO - PROCESS | 9465 | RSS: Main: 199045120 02:54:09 INFO - PROCESS | 9465 | 02:54:11 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:54:11 INFO - PROCESS | 9465 | RSS: Main: 199282688 02:54:11 INFO - PROCESS | 9465 | 02:54:13 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:54:14 INFO - PROCESS | 9465 | RSS: Main: 199880704 02:54:14 INFO - PROCESS | 9465 | 02:54:16 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:54:17 INFO - PROCESS | 9465 | RSS: Main: 199856128 02:54:17 INFO - PROCESS | 9465 | 02:54:20 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:54:20 INFO - PROCESS | 9465 | RSS: Main: 199860224 02:54:20 INFO - PROCESS | 9465 | 02:54:23 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:54:24 INFO - PROCESS | 9465 | RSS: Main: 200192000 02:54:24 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | Cycle 1(1): loaded http://localhost:41138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41138/tests/kraken/driver.html?testName=ai-astar) 02:54:26 INFO - PROCESS | 9465 | RSS: Main: 203112448 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | __start_tp_report 02:54:26 INFO - PROCESS | 9465 | _x_x_mozilla_page_load 02:54:26 INFO - PROCESS | 9465 | _x_x_mozilla_page_load_details 02:54:26 INFO - PROCESS | 9465 | |i|pagename|runs| 02:54:26 INFO - PROCESS | 9465 | |0;ai-astar;112;116;114;114;118;116;116;114;117;132 02:54:26 INFO - PROCESS | 9465 | |1;audio-beat-detection;153;125;150;170;124;155;156;124;206;131 02:54:26 INFO - PROCESS | 9465 | |2;audio-dft;171;165;163;163;167;164;163;165;166;166 02:54:26 INFO - PROCESS | 9465 | |3;audio-fft;78;86;76;170;79;77;76;77;168;77 02:54:26 INFO - PROCESS | 9465 | |4;audio-oscillator;88;84;133;84;85;85;149;84;84;138 02:54:26 INFO - PROCESS | 9465 | |5;imaging-gaussian-blur;119;119;119;118;120;118;120;118;119;120 02:54:26 INFO - PROCESS | 9465 | |6;imaging-darkroom;150;149;148;149;150;150;149;149;148;148 02:54:26 INFO - PROCESS | 9465 | |7;imaging-desaturate;97;97;95;96;95;95;96;97;97;95 02:54:26 INFO - PROCESS | 9465 | |8;json-parse-financial;65;66;67;66;66;66;66;65;66;64 02:54:26 INFO - PROCESS | 9465 | |9;json-stringify-tinderbox;66;67;66;66;67;66;71;66;66;66 02:54:26 INFO - PROCESS | 9465 | |10;stanford-crypto-aes;87;84;86;83;84;82;82;83;85;83 02:54:26 INFO - PROCESS | 9465 | |11;stanford-crypto-ccm;135;135;137;134;136;145;136;146;176;145 02:54:26 INFO - PROCESS | 9465 | |12;stanford-crypto-pbkdf2;182;179;179;179;173;178;172;175;175;175 02:54:26 INFO - PROCESS | 9465 | |13;stanford-crypto-sha256-iterative;74;73;73;70;71;72;70;69;72;71 02:54:26 INFO - PROCESS | 9465 | __end_tp_report 02:54:26 INFO - PROCESS | 9465 | __start_cc_report 02:54:26 INFO - PROCESS | 9465 | _x_x_mozilla_cycle_collect,927 02:54:26 INFO - PROCESS | 9465 | __end_cc_report 02:54:26 INFO - PROCESS | 9465 | __startTimestamp1472550866498__endTimestamp 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | ------- Summary: start ------- 02:54:26 INFO - PROCESS | 9465 | Number of tests: 14 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.00 stddev:5.59 (4.8%) stddev-sans-first:5.64 02:54:26 INFO - PROCESS | 9465 | Values: 112.0 116.0 114.0 114.0 118.0 116.0 116.0 114.0 117.0 132.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:154.00 stddev:25.69 (16.7%) stddev-sans-first:27.22 02:54:26 INFO - PROCESS | 9465 | Values: 153.0 125.0 150.0 170.0 124.0 155.0 156.0 124.0 206.0 131.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.45 (1.5%) stddev-sans-first:1.50 02:54:26 INFO - PROCESS | 9465 | Values: 171.0 165.0 163.0 163.0 167.0 164.0 163.0 165.0 166.0 166.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#3] audio-fft Cycles:10 Average:96.40 Median:77.00 stddev:38.38 (49.8%) stddev-sans-first:40.12 02:54:26 INFO - PROCESS | 9465 | Values: 78.0 86.0 76.0 170.0 79.0 77.0 76.0 77.0 168.0 77.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:84.00 stddev:26.94 (32.1%) stddev-sans-first:28.14 02:54:26 INFO - PROCESS | 9465 | Values: 88.0 84.0 133.0 84.0 85.0 85.0 149.0 84.0 84.0 138.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:119.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 02:54:26 INFO - PROCESS | 9465 | Values: 119.0 119.0 119.0 118.0 120.0 118.0 120.0 118.0 119.0 120.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 02:54:26 INFO - PROCESS | 9465 | Values: 150.0 149.0 148.0 149.0 150.0 150.0 149.0 149.0 148.0 148.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.50 stddev:0.94 (1.0%) stddev-sans-first:0.93 02:54:26 INFO - PROCESS | 9465 | Values: 97.0 97.0 95.0 96.0 95.0 95.0 96.0 97.0 97.0 95.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 02:54:26 INFO - PROCESS | 9465 | Values: 65.0 66.0 67.0 66.0 66.0 66.0 66.0 65.0 66.0 64.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.64 02:54:26 INFO - PROCESS | 9465 | Values: 66.0 67.0 66.0 66.0 67.0 66.0 71.0 66.0 66.0 66.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.66 (2.0%) stddev-sans-first:1.33 02:54:26 INFO - PROCESS | 9465 | Values: 87.0 84.0 86.0 83.0 84.0 82.0 82.0 83.0 85.0 83.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:141.00 stddev:12.68 (9.0%) stddev-sans-first:13.15 02:54:26 INFO - PROCESS | 9465 | Values: 135.0 135.0 137.0 134.0 136.0 145.0 136.0 146.0 176.0 145.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:178.50 stddev:3.16 (1.8%) stddev-sans-first:2.71 02:54:26 INFO - PROCESS | 9465 | Values: 182.0 179.0 179.0 179.0 173.0 178.0 172.0 175.0 175.0 175.0 02:54:26 INFO - PROCESS | 9465 | 02:54:26 INFO - PROCESS | 9465 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.58 (2.2%) stddev-sans-first:1.39 02:54:26 INFO - PROCESS | 9465 | Values: 74.0 73.0 73.0 70.0 71.0 72.0 70.0 69.0 72.0 71.0 02:54:26 INFO - PROCESS | 9465 | -------- Summary: end -------- 02:54:26 INFO - PROCESS | 9465 | 02:54:27 INFO - TEST-INFO | 9465: exit 0 02:54:27 INFO - TEST-OK | kraken | took 66598ms 02:54:27 INFO - SUITE-END | took 1186s 02:54:28 INFO - Completed test suite (00:19:46) 02:54:28 INFO - javascript benchmark 02:54:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6278.969035572265, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.062067965872, 2668.359593697512, 2669.145873320538, 2696.245051385613, 2702.6081218223358, 4635.443746750386, 4730.432348118226, 4796.496367881375, 4815.0610630926985, 4884.169691152504, 4744.525547445253, 4746.382970213876, 4775.068861572004, 4807.254875494304, 4841.927371089437, 4351.0, 4435.289738180916, 4435.489918659363, 4549.11292298002, 4554.066416384633, 4452.866414007569, 4505.954940450602, 4524.886877828064, 4536.138133754593, 4538.160440318552, 4281.636060934824, 4349.478062632473, 4367.934480982788, 4404.66964977628, 4462.665300102472, 4354.738715677038, 4356.6950313477755, 4375.16871794358, 4461.397711308964, 4465.330200469955, 4384.605385515319, 4393.928064009578, 4396.252637051709, 4434.024514606781, 4449.755263460508, 4652.604528615038, 4704.458987216445, 4735.810567577293, 4805.927911081301, 4812.711237325771, 5073.594112471031, 5077.923831142536, 5083.567896728782, 5086.160783470723, 5116.539511443988, 5025.447200807908, 5059.367579052619, 5066.873328166826, 5080.923786143211, 5117.7185254810975, 4669.556392142741, 4717.9292310615365, 4736.384270044872, 4742.264948932921, 4757.619390448755, 5187.559057480081, 5209.166533354645, 5225.399079105951, 5228.398734145622, 5270.683758974474, 5006.824761133415, 5018.322526458955, 5019.322391477177, 5026.89946201074, 5081.466446023188, 4945.876353091129, 5052.520010598987, 5056.82301119459, 5075.543201111917, 5090.363704536933, 5054.7472626368535, 5060.822871199491, 5064.670796398223, 5071.290019397287, 5071.822486212965, 5028.748562571856, 5037.269595908573, 5038.193888977746, 5039.118154323052, 5095.133827249377, 4275.273203555403, 4376.343548467756, 4377.343398490252, 4395.670324725658, 4454.1982443159895, 3840.2895464339185, 3840.5967373425947, 3844.6539811417106, 3891.6497515223764, 3894.9805250973563, 4452.30989196675, 4462.6876118672035, 4462.732236065846, 4473.5526447355005, 4515.706479078849, 4969.3291405659775, 5080.958403527268, 5103.948960510422, 5123.257127716461, 5146.073706732749, 4426.44669416323, 4444.28891377378, 4468.017036252019, 4505.346724724896, 4510.413646225969, 4663.183942809995, 4683.414573178353, 4683.765811709401, 4697.4832768395445, 4742.52574742523, 4649.279766486422, 4725.078609671081, 4759.690620109682, 4768.356271903249, 4803.975980120007, 5095.617828662791, 5096.108181068373, 5101.056304583664, 5108.131617624938, 5175.4565770593545, 4735.360726301905, 4769.713817170981, 4780.593649539828, 4782.0, 4828.4688684244, 4929.088118698052, 4995.725235112103, 5023.547880690755, 5041.344625198701, 5065.29085927963, 5130.050940576006, 5130.589552835839, 5134.76893539799, 5137.5889928806355, 5169.793208271627, 4970.502949705001, 4976.2539783261955, 4980.950190498049, 4989.351384320015, 5048.873778155576, 4837.467878533429, 4945.62907781925, 4956.454789973172, 4970.279309500174, 5028.748562571784, 4780.832670856643, 4950.777215025405, 4966.255061740768, 4967.329410529533, 5018.272350509083, 5094.745262736774, 5103.974480127576, 5104.438511763628, 5109.182530795055, 5157.948420515897, 4685.835995740133, 4763.499832517675, 4782.0914026334885, 4797.592204662643, 4969.4782047884455], "value": 4696.700028075078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.8792021795097, 549.535642382187, 558.2240685447229, 564.3820017081296, 565.5532129617602, 34431.31137377251, 38720.0, 38731.80634096826, 38738.806305968465, 38765.22469550614, 38992.41511377331, 39558.208835823265, 39696.40455393164, 39711.80144099276, 39929.600703992954, 7646.502977306485, 7843.137254901956, 7852.725154619589, 7858.017747781528, 7866.0560732711865, 7659.119201291839, 7743.419243556727, 7764.223577642247, 7772.0, 7779.9222007780045, 7663.080430348338, 7733.497322674037, 7735.419843511731, 7739.57432341221, 7787.182345853689, 7671.156172820985, 7698.807529811744, 7703.152653208114, 7728.381729461629, 7737.729179478748, 7644.426667999866, 7708.768736937901, 7710.306072453506, 7769.494982826155, 7775.4168437367425, 36052.0, 36371.27257454836, 36389.45415818765, 36398.8180059098, 36485.63514364849, 2955.246412164906, 2957.216337670519, 2957.275467510474, 3105.596272484585, 3313.1717070732316, 28241.576376354373, 28718.712812871814, 28988.855055724798, 29260.41479170426, 30017.0, 2975.36029753604, 3018.8792448302042, 3061.0971011959705, 3071.370369074357, 3271.5419841222247, 238067.0, 239050.0, 239055.0, 240246.0, 240763.0, 30673.233169170948, 52516.0, 52533.21200182, 52651.0, 52713.0, 31383.529247061313, 32680.182995424828, 32963.0, 33152.50271245885, 33412.83293583565, 13457.31783527059, 13538.458461661423, 13582.93208533951, 13585.456581736818, 13611.25138117413, 10491.895081049091, 10533.789324213472, 10559.841602375971, 10567.471626418648, 10590.352411897025, 7648.655810488542, 7747.341475974493, 7757.185495523002, 7775.1447340792465, 7807.609619519001, 2988.417258634589, 3092.2424006118645, 3097.3650401667605, 3131.906042818719, 3138.3095718941795, 797.6211299632744, 858.3690987124459, 890.1143362354499, 969.4377261188494, 970.8446648536342, 26267.21198364052, 26885.596716049276, 27218.72781272162, 28293.0, 28401.28996775097, 947.5357075033185, 964.3731574476647, 1030.1141018723893, 1037.4345981440133, 1075.983860242097, 14715.411383544539, 14741.852581474048, 14784.408623654934, 14856.331465084097, 14911.776323355158, 368797.0, 370874.0, 370944.0, 373602.0, 376083.0, 48946.0, 49631.0, 49636.25545616819, 49654.75172624186, 49678.751606241734, 1131.603938621476, 1179.262960649594, 1188.8751681073536, 1208.2448469706433, 1209.29256385014, 25544.361390965376, 26030.609540856523, 27100.457990839677, 27828.86085569559, 27842.721572784012, 41268.174636507705, 41828.790856045525, 41942.370864436445, 41987.79006105072, 42028.57971420369, 334511.0, 336287.0, 338414.0, 339955.0, 340734.0, 25161.87419062893, 25532.872335638203, 25565.872170639028, 25568.744312556635, 25579.616305755055, 40882.59117408788, 41293.58706412897, 41500.58499415088, 41525.58474415217, 42491.36262955996, 34731.0, 35524.0, 35665.46501802527, 35710.4643430354, 36394.27211455809, 34767.82616087005, 34861.0, 35034.474482882266, 35060.12349691278, 35287.0, 27148.72851271462, 34274.14314642154, 34644.82677586596, 34947.30105397929, 35334.29331413409, 30109.0, 31324.53013204758, 31914.36171276608, 32010.839945800122, 32365.0, 24654.383640409134, 24709.752902470744, 25213.243602691215, 25376.365590860376, 25763.742362576133], "value": 16157.441112061582, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.1504663109071, 342.14975785173823, 357.5441312326783, 362.31884057971, 364.775662967275, 15833.524994250161, 15996.440124595641, 17163.141842907837, 17230.913845430787, 17420.65158696825, 15362.769558456604, 16336.34654613817, 16518.091504967222, 16537.91731041343, 16541.751873721874, 4708.9529104708945, 5022.84931452057, 5056.039352523009, 5059.519345662175, 5060.54455099041, 4996.675216110941, 5054.342935418391, 5065.518775716319, 5066.341375621182, 5084.237364395333, 4996.600271978251, 5153.922691159635, 5410.08028635131, 5455.018096742585, 5534.944650553483, 5400.545449096402, 5463.535599474049, 5483.820978489604, 5494.2857428534435, 5498.615096943216, 5244.449332820037, 5300.681959082467, 5308.6549374290935, 5325.520703136697, 5333.333333333333, 11995.820062699066, 12145.0, 12149.757004859854, 18861.622767544708, 19577.119029643556, 1891.4609336339215, 1952.3069310394746, 1978.307592342683, 2110.807393822485, 2292.106078629336, 8927.37508374414, 8933.330000250007, 8936.240419564345, 9465.574049167804, 9513.857292140623, 1603.1503303249297, 1711.5721069732567, 1722.345508706696, 1738.322054398773, 1766.5406994181476, 70777.0, 70828.6458567709, 70904.6454767728, 71459.64270178616, 71545.64227178883, 9757.512124393752, 9793.608255669693, 9969.152622027208, 10043.799124017478, 10073.395596264247, 13501.797473037912, 13540.0, 13597.524086657117, 13613.455461781417, 13649.795253071212, 6796.184457864989, 7062.364387205176, 7104.893426598605, 7341.375983041395, 7349.522281051714, 6987.9301206987275, 7033.296670332926, 7118.501704880712, 7166.641667916583, 7229.8554028919125, 4133.91732165361, 4231.2806822839575, 4245.532991370947, 4281.272183728774, 4396.4284642996845, 1789.6599646067466, 1842.8065053169491, 1855.072463768116, 1868.3460788723837, 1882.397632757532, 761.432732614195, 818.9713360032489, 854.974350769478, 933.4679232837218, 946.7491114854569, 16527.33890644361, 16692.415765448393, 17248.223829927683, 17507.0, 17679.646407071785, 850.9320802392957, 862.5687156421789, 871.6861929705301, 894.2845723421237, 900.9324300677475, 9098.79806493439, 9496.240300775922, 9725.0, 9795.9020409795, 9800.26498012652, 356994.0, 363506.0, 363678.99531051563, 365520.0, 377915.0, 64547.0, 73007.63496182485, 76517.6174119137, 77918.6104069476, 80244.0, 799.2367289238879, 846.2891171415918, 846.9449485783405, 847.9660813567635, 848.3467729847982, 15135.318910648826, 15474.381024759334, 15769.842301576837, 15782.842171578597, 16279.267432965307, 37432.625673742914, 37914.43128353022, 37946.810265948494, 38038.80980595079, 39576.2084758309, 52637.47362526326, 53231.46768532265, 54303.72848135892, 54535.454645453035, 54552.0, 10906.291091079054, 10919.290246133976, 11117.944410277896, 11418.828717569077, 11523.193376463567, 12289.631311060682, 12921.0, 12930.935345323589, 13135.883449906865, 13269.800952985519, 10014.0, 11189.104871610089, 11224.382658953837, 11396.48715807774, 11443.370614616277, 11275.718107047389, 11376.55404088092, 11423.942880285545, 11544.307341559534, 11904.523819047141, 11121.610743623934, 11186.608468703556, 11285.0, 11488.368139752394, 11643.941780291045, 11642.53429862796, 11700.765984680089, 11883.0, 11931.582394616147, 12178.57374991871, 11314.60398886068, 11377.203595748219, 11418.143639226924, 11589.362585057566, 11832.0], "value": 8386.119955228416, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.622197673663, 1360.2518614761882, 1403.7332906747718, 1610.5168449465157, 1644.3587001069577, 6907.0675458813175, 7412.184659687437, 7620.237976202391, 8008.3593312535, 8060.032796064465, 7655.387568994467, 7928.563928983904, 7936.246056624625, 7936.880946785803, 7938.245866642674, 2164.2641501889357, 2200.878951657658, 2201.966970495444, 2202.2292197730744, 2206.293985924505, 2099.674550444676, 2129.6805479178092, 2164.675298705199, 2166.8483206175574, 2169.045619927235, 2128.1487405037956, 2140.475583482041, 2150.3441450357636, 2154.633712268918, 2156.8490205685607, 2080.6046851098317, 2080.8127268545904, 2092.393205970267, 2093.194120263694, 2098.4544018555134, 2037.8165965063067, 2074.408793493847, 2084.3642688979853, 2087.039961617658, 2088.853780235384, 7536.660850261751, 7600.619969001527, 7847.411444141712, 7903.407244456689, 7905.96047019767, 4225.19721252961, 4356.302991521373, 4370.606645401929, 4374.5844144806515, 4394.780260986938, 2833.759130473912, 2955.5123404638207, 2958.3047983724023, 2991.9401611967637, 3000.144958686764, 963.513425720014, 986.442659897163, 998.2213873178932, 999.4053538144792, 1005.4419797012655, 10704.732381690443, 10727.141828653766, 10744.0, 10776.73058173544, 10798.136149108132, 3930.21395720857, 4011.8194681239415, 4226.535081141072, 4259.212045771542, 4259.531451540328, 9140.177384035469, 9201.217896478875, 9214.539273036322, 9252.398594091363, 9269.536523173814, 4543.273076307775, 4564.771761411983, 4570.520095390003, 4572.177008138567, 4587.0, 3683.244934788362, 3914.4324073009825, 4013.7792421417103, 4196.874093777192, 4218.599233072853, 3610.476480910306, 3624.9700167906058, 3627.6553727395853, 3645.781253124821, 3651.72612054097, 1171.8769529199483, 1173.6831055614937, 1179.3572502985894, 1184.538030168235, 1214.9976269577635, 763.282514436428, 779.4582764978286, 782.7456076775071, 787.7597332813432, 798.1260519730886, 4670.509596492319, 4760.690555113906, 4795.352627395257, 4850.563449289581, 4924.532169443897, 395.12676983865975, 412.04405778593974, 413.3551659411328, 414.48810718762303, 415.82327510807784, 3293.7035666790102, 3332.274838248716, 3349.6315405305395, 3369.7809642373168, 3383.204946837491, 9256.0, 9441.811163776685, 9592.808143837225, 9676.70969870905, 9727.0, 9537.141657250742, 9548.856767148498, 9549.331546791796, 9631.518424078908, 9642.132208101164, 7140.285971402922, 7218.989341492195, 7302.525335853153, 7321.487495875238, 7380.261973802577, 4497.640188784824, 4503.594676479132, 4984.277279794482, 5105.2086926526445, 5194.091034069098, 8274.338052955869, 8305.335573154254, 8466.238038576557, 8788.736337909873, 8940.597673104596, 8449.45078569891, 8496.1079086695, 8506.702265420681, 8594.527300998256, 8743.0, 5831.7375718093635, 6393.904091438725, 6550.7707230246715, 6653.234877989094, 6839.1451068616425, 7403.629818508945, 7484.214157513383, 7494.662740176815, 7506.587137707478, 7514.849703006019, 6550.082988381535, 6634.104395906684, 6672.332766723289, 6793.218779840382, 6815.0, 6728.360805723449, 6817.386435220854, 6904.378605925491, 6910.619915904674, 6991.825204369931, 5905.793297234748, 5962.433568810956, 6054.9091763624465, 6055.2430946131735, 6055.969720151371, 4204.096119334357, 4245.426867372865, 4276.615104640598, 4298.398224248545, 4330.133973205308, 4399.472063352418, 4400.44994375703, 4407.801648925742, 4414.227510185769, 4421.579949904753], "value": 3974.784350228067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6781042568813, 299.51030065842343, 301.502520840613, 305.8088694565896, 307.1691075640393, 4936.506349365066, 4945.975270123648, 4966.478519755427, 4971.68595883228, 4975.701457912523, 4898.0897449994445, 4899.779509922053, 4901.460839307673, 4906.607471402288, 4915.336429582015, 3647.3070116677877, 3697.9815100924457, 3787.4508196311517, 3805.315043292206, 3811.2568049230413, 3801.182745709672, 3810.0, 3821.9808900955454, 3836.712246581518, 3848.942265866014, 3830.6743926766258, 3835.539735231776, 3836.386178211487, 3855.961440385602, 3877.6316249956208, 3531.858725650971, 3749.9125253676402, 3838.673712734421, 3841.9242612068665, 3864.782593483072, 3327.434336162858, 3330.766846320734, 3338.1487720631326, 3341.6800363856382, 3341.6992470677756, 4777.0, 4799.424069111729, 4800.855974320776, 4803.543663351976, 4803.639727020487, 4346.521882592912, 4348.673849461272, 4355.909163601457, 4356.847510337123, 4377.102693947733, 4988.904660042791, 5124.205748109049, 5128.435872054071, 5135.3324067870935, 5140.254663073833, 3587.1390866192187, 3591.515145455356, 3604.387254166798, 3616.6202548732267, 3624.6375362463805, 5343.679379237219, 5353.250544923714, 5388.413561490467, 5396.785723212285, 5397.379301380313, 3621.0947263184203, 3678.5585729712607, 3700.648438398348, 3705.3515634763808, 3735.533058367704, 3754.436834474796, 3758.699304055669, 3763.2285381496727, 3775.0, 3775.3581891078584, 4327.891802704958, 4331.350297455344, 4347.152305300499, 4351.477822661301, 4355.237833379146, 5012.373453318335, 5091.392289977576, 5159.690418574897, 5176.1459359206065, 5181.248718935733, 1291.14139097501, 1315.355475816843, 1315.5461365828965, 1318.8615195404536, 1321.378951892609, 803.4616806739499, 828.3828547731978, 836.2348451167236, 838.7986883148122, 842.9620667069996, 4340.717853339523, 4449.621782148489, 4586.793594288265, 4592.678512504092, 4594.450080205518, 5301.1783173608155, 5343.759530821122, 5353.839384818461, 5354.839354819362, 5357.892842143136, 4595.356650068993, 4613.331066995334, 4616.215243408628, 4621.30680397943, 4633.328167415706, 2680.182544324, 2787.456445993012, 2818.844963527026, 2821.1818572614125, 2832.22113918674, 4898.412190537087, 4934.827281045218, 4973.254011898244, 4999.850034492015, 5014.749262536859, 5138.922916156261, 5409.513143817076, 5412.675239485565, 5428.45715428454, 5436.510714035756, 4974.676646017997, 4975.477574854661, 4990.0, 4996.350474438373, 5002.399712034507, 5281.0, 5347.866303342447, 5363.865903352447, 5369.812056578001, 5377.27406800077, 4971.1797553403285, 5189.091908916, 5200.947990520198, 5205.947940520698, 5216.634835561475, 4986.15235409974, 4990.8752281193265, 4996.775145118406, 5008.874778130576, 5021.6735912165595, 3716.572594151599, 3755.1926335837925, 3771.283456143324, 3776.9802153418973, 3786.5077539920735, 5115.616328775282, 5275.261463395204, 5385.838424847261, 5398.058058358126, 5420.186971954238, 5154.845354639367, 5164.509371609691, 5171.3535808024, 5171.81898633546, 5175.792968281226, 5171.92242116361, 5190.97404512975, 5207.4271830097905, 5207.71357575337, 5209.531142197069, 5021.974890125526, 5108.770105345343, 5113.8977220454635, 5116.079105760999, 5147.6139289554185, 4969.180085285887, 5028.2960385546785, 5196.350456192976, 5203.424304969065, 5215.817446389358, 5033.748312584283, 5037.697738135724, 5056.266841307916, 5060.1903695408555, 5061.721605311596], "value": 3869.6712924838694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.2308506495451, 590.4390828712724, 607.1681795939563, 612.3019757476475, 643.594535442671, 11467.254628449145, 12234.0, 12608.747825043516, 12661.49354025839, 12685.0, 12303.753924921497, 12391.25652460853, 12423.31671758053, 12445.875541244584, 12474.688132796684, 592.7095723095673, 713.0587624335878, 728.8760910645177, 729.6315360742817, 729.7810656802965, 717.5694583250034, 722.7542635503928, 722.9385502232317, 741.6032422653881, 748.3638906929122, 780.6526095887332, 783.5298820707559, 783.7766236622564, 784.1178673991759, 785.2932360875201, 778.8091917480197, 778.9143194248628, 780.2821404307994, 781.281221276427, 782.4405550031726, 566.1818672018934, 571.1746526269542, 572.6220694341714, 574.0528128587822, 574.4887050525036, 12685.556005539762, 12700.237985720887, 12770.680732981657, 12777.29724865132, 12792.168509046975, 11991.64025079249, 12132.090093243041, 12251.877481225163, 12298.815517767242, 12700.428480718298, 10221.802267754112, 10509.842352364643, 10513.579456821719, 10560.0, 10649.0, 3126.3590963852357, 3172.191091271734, 3177.5551422800827, 3252.8777571737714, 3262.706356427933, 63999.0, 65199.348006520275, 67147.3285267146, 67733.66133169353, 67867.9999999995, 8577.571121443903, 8678.862291754313, 9581.760455988657, 10037.0, 10303.124234440007, 19811.306604268782, 20704.48238794042, 20741.792582073987, 20765.377038688865, 20891.477713057295, 7048.753293634698, 7117.501774875813, 7167.92832071683, 7183.389411899942, 7183.928160718326, 3617.3488772020764, 3651.379265524867, 3657.6342365763744, 3672.192117734094, 3716.8141592920247, 2931.3257950671464, 3018.818870867711, 3042.3763128558594, 3044.1476386611785, 3052.0080973683644, 479.61870313101167, 479.78169932680544, 485.01057842002626, 486.19534670121004, 497.1895809830026, 509.3251441839577, 575.666113654088, 577.4225774225774, 595.3837777899939, 598.3986093975527, 7192.92807071933, 7393.926060739432, 7622.428317876182, 7725.922740772633, 7914.366850651934, 544.6051612580848, 548.4022415566972, 555.6666000399728, 611.703323887914, 621.2513920725515, 3517.50754894315, 3747.4940882980995, 3794.1083845296334, 3828.253490569368, 3865.9806700966315, 84337.0, 93013.0, 93628.0, 95162.0, 97707.0, 45448.54551454443, 48706.75646621744, 55758.72120639452, 65763.0, 80140.0, 68615.0, 71453.642731786, 71769.0, 73281.0, 73337.63331183417, 7282.817929551804, 7456.66445009965, 7508.6996520140765, 7618.238176182337, 7690.6539205737, 31612.209694757814, 38255.04362390962, 38732.2253554933, 41835.372469412374, 45651.771741141085, 60969.695151523956, 64581.0, 65280.0, 75923.0, 83820.16179838123, 10978.670639880816, 11216.158788090763, 11244.368107933058, 11368.943155284502, 11621.941890290833, 11741.41292935367, 11982.520699172284, 12081.697957551132, 12352.938235308766, 12430.875691242973, 10641.148708103488, 10883.945580272048, 10931.83602245983, 11045.116390688565, 11203.271787333797, 11204.66386008421, 11248.26886252391, 11301.71745706364, 11311.490982905954, 11584.826227606762, 10763.677089687322, 10910.345379277269, 10976.341419514854, 11003.834942476029, 11167.49746261404, 8383.538905360263, 8582.699605513777, 8678.52268125234, 8729.3889427742, 8915.465072095694, 8735.694250701195, 8775.692850750449, 9245.0, 9286.860697089414, 9475.763105922131], "value": 6259.922200789932, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 114.0, 114.0, 118.0, 116.0, 116.0, 114.0, 117.0, 132.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 150.0, 170.0, 124.0, 155.0, 156.0, 124.0, 206.0, 131.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 163.0, 163.0, 167.0, 164.0, 163.0, 165.0, 166.0, 166.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 86.0, 76.0, 170.0, 79.0, 77.0, 76.0, 77.0, 168.0, 77.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 133.0, 84.0, 85.0, 85.0, 149.0, 84.0, 84.0, 138.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 118.0, 120.0, 118.0, 120.0, 118.0, 119.0, 120.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 149.0, 150.0, 150.0, 149.0, 149.0, 148.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 71.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 83.0, 84.0, 82.0, 82.0, 83.0, 85.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 137.0, 134.0, 136.0, 145.0, 136.0, 146.0, 176.0, 145.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 179.0, 179.0, 173.0, 178.0, 172.0, 175.0, 175.0, 175.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 70.0, 71.0, 72.0, 70.0, 69.0, 72.0, 71.0], "value": 71.5, "unit": "score"}]}]} 02:54:28 INFO - Return code: 0 02:54:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:54:28 ERROR - # TBPL SUCCESS # 02:54:28 INFO - Running post-action listener: _resource_record_post_action 02:54:28 INFO - [mozharness: 2016-08-30 09:54:28.304867Z] Finished run-tests step (success) 02:54:28 INFO - Running post-run listener: _resource_record_post_run 02:54:28 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418295808; Read time: 8; Write time: 1133840 02:54:28 INFO - TinderboxPrint: CPU usage
13.5% 02:54:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:54:28 INFO - TinderboxPrint: I/O write bytes / time
418,295,808 / 1,133,840 02:54:28 INFO - TinderboxPrint: CPU idle
8,301.7 (86.5%) 02:54:28 INFO - TinderboxPrint: CPU user
1,221.4 (12.7%) 02:54:28 INFO - TinderboxPrint: Swap in / out
0 / 0 02:54:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 126554112; Read time: 0; Write time: 339004 02:54:28 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291741696; Read time: 0; Write time: 794836 02:54:28 INFO - Running post-run listener: _upload_blobber_files 02:54:28 INFO - Blob upload gear active. 02:54:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:54:28 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 02:54:28 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'] 02:54:28 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 02:54:29 INFO - (blobuploader) - INFO - Open directory for files ... 02:54:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:54:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:33 INFO - (blobuploader) - INFO - Done attempting. 02:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:34 INFO - (blobuploader) - INFO - Done attempting. 02:54:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:54:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:34 INFO - (blobuploader) - INFO - Done attempting. 02:54:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:54:34 INFO - Return code: 0 02:54:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:54:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:54:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b824b02a27b4f7b1e8a773b5b8df88cf5ef08bffff23e37d4b4c26cb63fd47b350d1d2ef7236a7f063ae563271c4409f9268fc00a24d0a90c0e5d021ac55b9ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4b90db79b679448a73bd6c72b490e2442edc2043f58c38c09218831a7b96ed21bcdb2d7ae702dd0f13b4b9dc8d66e2de98230f18279f975e84041da8f24c712a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/74fe5c78ed39737f6cb17becf4b92cf6acd611f76fb03c365f8f981396a734318c3db42d3f4cc2e9988d3196730772e3f6836147b9c7638015f1594360f35d05"} 02:54:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:54:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:54:34 INFO - Contents: 02:54:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b824b02a27b4f7b1e8a773b5b8df88cf5ef08bffff23e37d4b4c26cb63fd47b350d1d2ef7236a7f063ae563271c4409f9268fc00a24d0a90c0e5d021ac55b9ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4b90db79b679448a73bd6c72b490e2442edc2043f58c38c09218831a7b96ed21bcdb2d7ae702dd0f13b4b9dc8d66e2de98230f18279f975e84041da8f24c712a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/74fe5c78ed39737f6cb17becf4b92cf6acd611f76fb03c365f8f981396a734318c3db42d3f4cc2e9988d3196730772e3f6836147b9c7638015f1594360f35d05"} 02:54:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:54:34 INFO - Copying logs to upload dir... 02:54:34 INFO - mkdir: /builds/slave/test/build/upload/logs 02:54:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.563945 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-30 02:54:34.394076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 02:54:34.397504) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1472549238.871303-838109831 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/b824b02a27b4f7b1e8a773b5b8df88cf5ef08bffff23e37d4b4c26cb63fd47b350d1d2ef7236a7f063ae563271c4409f9268fc00a24d0a90c0e5d021ac55b9ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4b90db79b679448a73bd6c72b490e2442edc2043f58c38c09218831a7b96ed21bcdb2d7ae702dd0f13b4b9dc8d66e2de98230f18279f975e84041da8f24c712a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/74fe5c78ed39737f6cb17becf4b92cf6acd611f76fb03c365f8f981396a734318c3db42d3f4cc2e9988d3196730772e3f6836147b9c7638015f1594360f35d05"} build_url:https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/EOqEJ_imR8C_8oxNHt9dxQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b824b02a27b4f7b1e8a773b5b8df88cf5ef08bffff23e37d4b4c26cb63fd47b350d1d2ef7236a7f063ae563271c4409f9268fc00a24d0a90c0e5d021ac55b9ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4b90db79b679448a73bd6c72b490e2442edc2043f58c38c09218831a7b96ed21bcdb2d7ae702dd0f13b4b9dc8d66e2de98230f18279f975e84041da8f24c712a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/74fe5c78ed39737f6cb17becf4b92cf6acd611f76fb03c365f8f981396a734318c3db42d3f4cc2e9988d3196730772e3f6836147b9c7638015f1594360f35d05"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 02:54:34.422217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:54:34.422531) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1472549238.871303-838109831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 02:54:34.505966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 02:54:34.506289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 02:54:34.506603) ========= ========= Total master_lag: 0.35 =========