builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1494502565.87 results: success (0) revision: 86754a7acc0e12cf3c575e9867958c2bacc8f465 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:05.865379) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:05.865820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:05.866094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:05.881454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:05.881843) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 04:36:05-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.5M=0s 2017-05-11 04:36:06 (40.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.420864 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:06.317556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:06.317933) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017110 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:06.369487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:06.370008) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 86754a7acc0e12cf3c575e9867958c2bacc8f465 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 86754a7acc0e12cf3c575e9867958c2bacc8f465 --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=74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 04:36:06,526 truncating revision to first 12 chars 2017-05-11 04:36:06,526 Setting DEBUG logging. 2017-05-11 04:36:06,526 attempt 1/10 2017-05-11 04:36:06,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/86754a7acc0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 04:36:06,951 unpacking tar archive at: mozilla-central-86754a7acc0e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747747 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:07.132369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:07.132716) ========= script_repo_revision: 86754a7acc0e12cf3c575e9867958c2bacc8f465 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:07.133105) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:07.133402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 04:36:07.143373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-11 04:36:07.143810) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:07 INFO - MultiFileLogger online at 20170511 04:36:07 in /builds/slave/test 04:36:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:36:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:07 INFO - {'append_to_log': False, 04:36:07 INFO - 'base_work_dir': '/builds/slave/test', 04:36:07 INFO - 'blob_upload_branch': 'Firefox', 04:36:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:07 INFO - 'branch': 'Firefox', 04:36:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:07 INFO - 'config_files': ('talos/linux_config.py',), 04:36:07 INFO - 'default_actions': ('clobber', 04:36:07 INFO - 'read-buildbot-config', 04:36:07 INFO - 'download-and-extract', 04:36:07 INFO - 'populate-webroot', 04:36:07 INFO - 'create-virtualenv', 04:36:07 INFO - 'install', 04:36:07 INFO - 'run-tests'), 04:36:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:07 INFO - 'download_minidump_stackwalk': True, 04:36:07 INFO - 'download_symbols': 'ondemand', 04:36:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:07 INFO - 'gecko_profile': False, 04:36:07 INFO - 'gecko_profile_interval': 0, 04:36:07 INFO - 'installer_path': 'installer.exe', 04:36:07 INFO - 'log_level': 'info', 04:36:07 INFO - 'log_name': 'talos', 04:36:07 INFO - 'log_to_console': True, 04:36:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:07 INFO - 'opt_config_files': (), 04:36:07 INFO - 'pip_index': False, 04:36:07 INFO - 'suite': 'dromaeojs', 04:36:07 INFO - 'system_bits': '32', 04:36:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:07 INFO - 'title': 'talos-linux64-ix-042', 04:36:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:07 INFO - 'use_talos_json': True, 04:36:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:07 INFO - 'work_dir': 'build'} 04:36:07 INFO - [mozharness: 2017-05-11 11:36:07.396998Z] Running clobber step. 04:36:07 INFO - Running pre-action listener: _resource_record_pre_action 04:36:07 INFO - Running main action method: clobber 04:36:07 INFO - rmtree: /builds/slave/test/build 04:36:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:08 INFO - Running post-action listener: _resource_record_post_action 04:36:08 INFO - [mozharness: 2017-05-11 11:36:08.312806Z] Finished clobber step (success) 04:36:08 INFO - [mozharness: 2017-05-11 11:36:08.312907Z] Running read-buildbot-config step. 04:36:08 INFO - Running pre-action listener: _resource_record_pre_action 04:36:08 INFO - Running main action method: read_buildbot_config 04:36:08 INFO - Using buildbot properties: 04:36:08 INFO - { 04:36:08 INFO - "project": "", 04:36:08 INFO - "product": "firefox", 04:36:08 INFO - "who": "cbook@mozilla.com", 04:36:08 INFO - "installer_path": "public/build/target.tar.bz2", 04:36:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:36:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:36:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:36:08 INFO - "stage_platform": "linux64-pgo", 04:36:08 INFO - "basedir": "/builds/slave/test", 04:36:08 INFO - "buildnumber": 177, 04:36:08 INFO - "platform": "ubuntu64_hw", 04:36:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:36:08 INFO - "slavebuilddir": "test", 04:36:08 INFO - "taskId": "U_LSUC7tTca4MoDDH_R_ew", 04:36:08 INFO - "branch": "mozilla-central", 04:36:08 INFO - "script_repo_revision": "production", 04:36:08 INFO - "revision": "86754a7acc0e12cf3c575e9867958c2bacc8f465", 04:36:08 INFO - "slavename": "talos-linux64-ix-042", 04:36:08 INFO - "repo_path": "mozilla-central" 04:36:08 INFO - } 04:36:08 INFO - Finding installer, test and symbols from parent task. 04:36:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U_LSUC7tTca4MoDDH_R_ew'}, attempt #1 04:36:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U_LSUC7tTca4MoDDH_R_ew'}, attempt #1 04:36:09 INFO - Task dependencies: dJAozASwRJCoBPuu99lfuQ 04:36:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ'}, attempt #1 04:36:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2 04:36:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/test_packages.json 04:36:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.crashreporter-symbols.zip 04:36:09 INFO - Running post-action listener: _resource_record_post_action 04:36:09 INFO - [mozharness: 2017-05-11 11:36:09.720427Z] Finished read-buildbot-config step (success) 04:36:09 INFO - [mozharness: 2017-05-11 11:36:09.720644Z] Running download-and-extract step. 04:36:09 INFO - Running pre-action listener: _resource_record_pre_action 04:36:09 INFO - Running main action method: download_and_extract 04:36:09 INFO - mkdir: /builds/slave/test/build/tests 04:36:09 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')]} 04:36:09 INFO - trying https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.test_packages.json 04:36:09 INFO - Downloading https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:36:10 INFO - Downloaded 986 bytes. 04:36:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:36:10 INFO - Using the following test package requirements: 04:36:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:36:10 INFO - u'common': [u'target.common.tests.zip'], 04:36:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:36:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:36:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:36:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:36:10 INFO - u'mozbase': [u'target.common.tests.zip'], 04:36:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:36:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:36:10 INFO - u'web-platform': [u'target.common.tests.zip', 04:36:10 INFO - u'target.web-platform.tests.zip'], 04:36:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:36:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:36:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.common.tests.zip 04:36:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:36:10 INFO - Fetch https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.common.tests.zip into memory 04:36:12 INFO - Content-Length response header: 60734028 04:36:12 INFO - Bytes received: 60734028 04:36:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:36:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.common.tests.zip 04:36:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:36:21 INFO - Fetch https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.common.tests.zip into memory 04:36:23 INFO - Content-Length response header: 60734028 04:36:23 INFO - Bytes received: 60734028 04:36:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.talos.tests.zip 04:36:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:36:34 INFO - Fetch https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.talos.tests.zip into memory 04:36:34 INFO - Content-Length response header: 14409352 04:36:34 INFO - Bytes received: 14409352 04:36:35 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')]} 04:36:35 INFO - trying https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2 04:36:35 INFO - Downloading https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:36:39 INFO - Downloaded 68545902 bytes. 04:36:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2 04:36:39 INFO - mkdir: /builds/slave/test/properties 04:36:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:39 INFO - Contents: 04:36:39 INFO - build_url:https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2 04:36:39 INFO - Running post-action listener: _resource_record_post_action 04:36:39 INFO - Running post-action listener: set_extra_try_arguments 04:36:39 INFO - [mozharness: 2017-05-11 11:36:39.978616Z] Finished download-and-extract step (success) 04:36:39 INFO - [mozharness: 2017-05-11 11:36:39.978803Z] Running populate-webroot step. 04:36:39 INFO - Running pre-action listener: _resource_record_pre_action 04:36:39 INFO - Running main action method: populate_webroot 04:36:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:39 INFO - '--tppagecycles', 04:36:39 INFO - '7'], 04:36:39 INFO - 'tests': ['tsvgm']}}, 04:36:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:36:39 INFO - 'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:36:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:36:39 INFO - 'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['damp', 'tps']}, 04:36:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:36:39 INFO - 'tests': ['damp', 'tps']}, 04:36:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['dromaeo_dom']}, 04:36:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:36:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:36:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['a11yr', 04:36:39 INFO - 'ts_paint', 04:36:39 INFO - 'tpaint', 04:36:39 INFO - 'sessionrestore', 04:36:39 INFO - 'sessionrestore_no_auto_restore', 04:36:39 INFO - 'tabpaint']}, 04:36:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:39 INFO - 'ts_paint', 04:36:39 INFO - 'tpaint', 04:36:39 INFO - 'sessionrestore', 04:36:39 INFO - 'sessionrestore_no_auto_restore', 04:36:39 INFO - 'tabpaint']}, 04:36:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:39 INFO - 'ts_paint', 04:36:39 INFO - 'tpaint', 04:36:39 INFO - 'sessionrestore', 04:36:39 INFO - 'sessionrestore_no_auto_restore', 04:36:39 INFO - 'tabpaint']}, 04:36:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:39 INFO - 'ts_paint', 04:36:39 INFO - 'tpaint', 04:36:39 INFO - 'sessionrestore', 04:36:39 INFO - 'sessionrestore_no_auto_restore', 04:36:39 INFO - 'tabpaint']}, 04:36:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['a11yr', 04:36:39 INFO - 'ts_paint', 04:36:39 INFO - 'tpaint', 04:36:39 INFO - 'sessionrestore', 04:36:39 INFO - 'sessionrestore_no_auto_restore', 04:36:39 INFO - 'tabpaint']}, 04:36:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['a11yr', 04:36:39 INFO - 'ts_paint', 04:36:39 INFO - 'tpaint', 04:36:39 INFO - 'sessionrestore', 04:36:39 INFO - 'sessionrestore_no_auto_restore', 04:36:39 INFO - 'tabpaint']}, 04:36:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:36:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:36:39 INFO - 'bloom_basic_ref']}, 04:36:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['tsvgx', 04:36:39 INFO - 'tsvgr_opacity', 04:36:39 INFO - 'tart', 04:36:39 INFO - 'tscrollx', 04:36:39 INFO - 'cart', 04:36:39 INFO - 'tsvg_static']}, 04:36:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:39 INFO - 'tsvgr_opacity', 04:36:39 INFO - 'tart', 04:36:39 INFO - 'tscrollx', 04:36:39 INFO - 'cart', 04:36:39 INFO - 'tsvg_static']}, 04:36:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:36:39 INFO - 'talos_options': ['--disable-e10s'], 04:36:39 INFO - 'tests': ['tp5o']}, 04:36:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:36:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:36:39 INFO - 'talos_options': ['--disable-e10s', 04:36:39 INFO - '--xperf_path', 04:36:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:39 INFO - 'tests': ['tp5n']}, 04:36:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:36:39 INFO - 'talos_options': ['--xperf_path', 04:36:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:39 INFO - 'tests': ['tp5n']}}, 04:36:39 INFO - 'talos.zip': {'path': '', 04:36:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:39 INFO - Running post-action listener: _resource_record_post_action 04:36:39 INFO - [mozharness: 2017-05-11 11:36:39.995957Z] Finished populate-webroot step (success) 04:36:39 INFO - [mozharness: 2017-05-11 11:36:39.996046Z] Running create-virtualenv step. 04:36:39 INFO - Running pre-action listener: _resource_record_pre_action 04:36:39 INFO - Running main action method: create_virtualenv 04:36:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:39 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 04:36:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:40 INFO - Using real prefix '/usr' 04:36:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:42 INFO - Installing pip.................done. 04:36:42 INFO - Return code: 0 04:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:36:42 INFO - Reading from file tmpfile_stdout 04:36:42 INFO - Output received: 04:36:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:36:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:43 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 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:36:43 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 04:36:43 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 04:36:43 INFO - Using env: {'DISPLAY': ':0', 04:36:43 INFO - 'HOME': '/home/cltbld', 04:36:43 INFO - 'LANG': 'en_US.UTF-8', 04:36:43 INFO - 'LANGUAGE': 'en_US:en', 04:36:43 INFO - 'LOGNAME': 'cltbld', 04:36:43 INFO - 'MAIL': '/var/mail/cltbld', 04:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:43 INFO - 'MOZ_NO_REMOTE': '1', 04:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:43 INFO - 'NO_EM_RESTART': '1', 04:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:43 INFO - 'PWD': '/builds/slave/test', 04:36:43 INFO - 'SHELL': '/bin/bash', 04:36:43 INFO - 'SHLVL': '1', 04:36:43 INFO - 'TERM': 'linux', 04:36:43 INFO - 'TMOUT': '86400', 04:36:43 INFO - 'USER': 'cltbld', 04:36:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:43 INFO - '_': '/tools/buildbot/bin/python'} 04:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:43 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 04:36:43 INFO - Cleaning up... 04:36:43 INFO - Return code: 0 04:36:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:43 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')]} 04:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:43 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')]} 04:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:43 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 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:36:43 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 04:36:43 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 04:36:43 INFO - Using env: {'DISPLAY': ':0', 04:36:43 INFO - 'HOME': '/home/cltbld', 04:36:43 INFO - 'LANG': 'en_US.UTF-8', 04:36:43 INFO - 'LANGUAGE': 'en_US:en', 04:36:43 INFO - 'LOGNAME': 'cltbld', 04:36:43 INFO - 'MAIL': '/var/mail/cltbld', 04:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:43 INFO - 'MOZ_NO_REMOTE': '1', 04:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:43 INFO - 'NO_EM_RESTART': '1', 04:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:43 INFO - 'PWD': '/builds/slave/test', 04:36:43 INFO - 'SHELL': '/bin/bash', 04:36:43 INFO - 'SHLVL': '1', 04:36:43 INFO - 'TERM': 'linux', 04:36:43 INFO - 'TMOUT': '86400', 04:36:43 INFO - 'USER': 'cltbld', 04:36:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:43 INFO - '_': '/tools/buildbot/bin/python'} 04:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:43 INFO - Downloading/unpacking psutil>=3.1.1 04:36:43 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 04:36:43 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 04:36:43 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 04:36:43 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 04:36:43 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 04:36:43 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 04:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:45 INFO - Installing collected packages: psutil 04:36:45 INFO - Running setup.py install for psutil 04:36:45 INFO - building 'psutil._psutil_linux' extension 04:36:45 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 04:36:45 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 04:36:45 INFO - building 'psutil._psutil_posix' extension 04:36:45 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 04:36:45 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 04:36:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:45 INFO - Successfully installed psutil 04:36:45 INFO - Cleaning up... 04:36:45 INFO - Return code: 0 04:36:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:36:46 INFO - Using env: {'DISPLAY': ':0', 04:36:46 INFO - 'HOME': '/home/cltbld', 04:36:46 INFO - 'LANG': 'en_US.UTF-8', 04:36:46 INFO - 'LANGUAGE': 'en_US:en', 04:36:46 INFO - 'LOGNAME': 'cltbld', 04:36:46 INFO - 'MAIL': '/var/mail/cltbld', 04:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:46 INFO - 'MOZ_NO_REMOTE': '1', 04:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:46 INFO - 'NO_EM_RESTART': '1', 04:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:46 INFO - 'PWD': '/builds/slave/test', 04:36:46 INFO - 'SHELL': '/bin/bash', 04:36:46 INFO - 'SHLVL': '1', 04:36:46 INFO - 'TERM': 'linux', 04:36:46 INFO - 'TMOUT': '86400', 04:36:46 INFO - 'USER': 'cltbld', 04:36:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:46 INFO - '_': '/tools/buildbot/bin/python'} 04:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:50 INFO - Installing collected packages: mozsystemmonitor 04:36:50 INFO - Running setup.py install for mozsystemmonitor 04:36:50 INFO - Successfully installed mozsystemmonitor 04:36:50 INFO - Cleaning up... 04:36:50 INFO - Return code: 0 04:36:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:36:50 INFO - Using env: {'DISPLAY': ':0', 04:36:50 INFO - 'HOME': '/home/cltbld', 04:36:50 INFO - 'LANG': 'en_US.UTF-8', 04:36:50 INFO - 'LANGUAGE': 'en_US:en', 04:36:50 INFO - 'LOGNAME': 'cltbld', 04:36:50 INFO - 'MAIL': '/var/mail/cltbld', 04:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:50 INFO - 'MOZ_NO_REMOTE': '1', 04:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:50 INFO - 'NO_EM_RESTART': '1', 04:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:50 INFO - 'PWD': '/builds/slave/test', 04:36:50 INFO - 'SHELL': '/bin/bash', 04:36:50 INFO - 'SHLVL': '1', 04:36:50 INFO - 'TERM': 'linux', 04:36:50 INFO - 'TMOUT': '86400', 04:36:50 INFO - 'USER': 'cltbld', 04:36:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:50 INFO - '_': '/tools/buildbot/bin/python'} 04:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:52 INFO - warning: no files found matching '*.txt' 04:36:52 INFO - no previously-included directories found matching 'build' 04:36:52 INFO - no previously-included directories found matching 'dist' 04:36:52 INFO - no previously-included directories found matching '.git*' 04:36:52 INFO - Installing collected packages: jsonschema, functools32 04:36:52 INFO - Running setup.py install for functools32 04:36:53 INFO - warning: no files found matching '*.txt' 04:36:53 INFO - no previously-included directories found matching 'build' 04:36:53 INFO - no previously-included directories found matching 'dist' 04:36:53 INFO - no previously-included directories found matching '.git*' 04:36:53 INFO - Successfully installed jsonschema functools32 04:36:53 INFO - Cleaning up... 04:36:53 INFO - Return code: 0 04:36:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:36:53 INFO - Using env: {'DISPLAY': ':0', 04:36:53 INFO - 'HOME': '/home/cltbld', 04:36:53 INFO - 'LANG': 'en_US.UTF-8', 04:36:53 INFO - 'LANGUAGE': 'en_US:en', 04:36:53 INFO - 'LOGNAME': 'cltbld', 04:36:53 INFO - 'MAIL': '/var/mail/cltbld', 04:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:53 INFO - 'MOZ_NO_REMOTE': '1', 04:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:53 INFO - 'NO_EM_RESTART': '1', 04:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:53 INFO - 'PWD': '/builds/slave/test', 04:36:53 INFO - 'SHELL': '/bin/bash', 04:36:53 INFO - 'SHLVL': '1', 04:36:53 INFO - 'TERM': 'linux', 04:36:53 INFO - 'TMOUT': '86400', 04:36:53 INFO - 'USER': 'cltbld', 04:36:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:53 INFO - '_': '/tools/buildbot/bin/python'} 04:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:53 INFO - Cleaning up... 04:36:53 INFO - Return code: 0 04:36:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:54 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 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:36:54 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 04:36:54 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 04:36:54 INFO - Using env: {'DISPLAY': ':0', 04:36:54 INFO - 'HOME': '/home/cltbld', 04:36:54 INFO - 'LANG': 'en_US.UTF-8', 04:36:54 INFO - 'LANGUAGE': 'en_US:en', 04:36:54 INFO - 'LOGNAME': 'cltbld', 04:36:54 INFO - 'MAIL': '/var/mail/cltbld', 04:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:54 INFO - 'MOZ_NO_REMOTE': '1', 04:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:54 INFO - 'NO_EM_RESTART': '1', 04:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:54 INFO - 'PWD': '/builds/slave/test', 04:36:54 INFO - 'SHELL': '/bin/bash', 04:36:54 INFO - 'SHLVL': '1', 04:36:54 INFO - 'TERM': 'linux', 04:36:54 INFO - 'TMOUT': '86400', 04:36:54 INFO - 'USER': 'cltbld', 04:36:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:54 INFO - '_': '/tools/buildbot/bin/python'} 04:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:54 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 04:36:54 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 04:36:54 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 04:36:54 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 04:36:54 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 04:36:54 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 04:36:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:57 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 04:36:57 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 04:36:57 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 04:36:57 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 04:36:57 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 04:36:57 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 04:36:57 INFO - Downloading docopt-0.6.1.tar.gz 04:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:57 INFO - Running setup.py install for blobuploader 04:36:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:57 INFO - Running setup.py install for requests 04:36:58 INFO - Running setup.py install for docopt 04:36:58 INFO - Successfully installed blobuploader requests docopt 04:36:58 INFO - Cleaning up... 04:36:58 INFO - Return code: 0 04:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 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 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:36:58 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 04:36:58 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 04:36:58 INFO - Using env: {'DISPLAY': ':0', 04:36:58 INFO - 'HOME': '/home/cltbld', 04:36:58 INFO - 'LANG': 'en_US.UTF-8', 04:36:58 INFO - 'LANGUAGE': 'en_US:en', 04:36:58 INFO - 'LOGNAME': 'cltbld', 04:36:58 INFO - 'MAIL': '/var/mail/cltbld', 04:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:58 INFO - 'MOZ_NO_REMOTE': '1', 04:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:58 INFO - 'NO_EM_RESTART': '1', 04:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:58 INFO - 'PWD': '/builds/slave/test', 04:36:58 INFO - 'SHELL': '/bin/bash', 04:36:58 INFO - 'SHLVL': '1', 04:36:58 INFO - 'TERM': 'linux', 04:36:58 INFO - 'TMOUT': '86400', 04:36:58 INFO - 'USER': 'cltbld', 04:36:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:58 INFO - '_': '/tools/buildbot/bin/python'} 04:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:58 INFO - Running setup.py (path:/tmp/pip-YIXju1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:58 INFO - Running setup.py (path:/tmp/pip-jNINyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:58 INFO - Running setup.py (path:/tmp/pip-ChrGMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:58 INFO - Running setup.py (path:/tmp/pip-Zy4cTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:58 INFO - Running setup.py (path:/tmp/pip-LUaYvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:59 INFO - Running setup.py (path:/tmp/pip-O7D9ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:59 INFO - Running setup.py (path:/tmp/pip-zTuO_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:59 INFO - Running setup.py (path:/tmp/pip-eCPTGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:59 INFO - Running setup.py (path:/tmp/pip-jMM327-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:59 INFO - Running setup.py (path:/tmp/pip-ODdc1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:59 INFO - Running setup.py (path:/tmp/pip-hLaHP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:59 INFO - Running setup.py (path:/tmp/pip-Sauxl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:59 INFO - Running setup.py (path:/tmp/pip-Za_rvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:59 INFO - Running setup.py (path:/tmp/pip-8dUofC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:59 INFO - Running setup.py (path:/tmp/pip-vYqfCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:59 INFO - Running setup.py (path:/tmp/pip-Uj_lhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:59 INFO - Running setup.py (path:/tmp/pip-uXA_ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:59 INFO - Running setup.py install for manifestparser 04:37:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Running setup.py install for mozcrash 04:37:00 INFO - Running setup.py install for mozdebug 04:37:00 INFO - Running setup.py install for mozdevice 04:37:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Running setup.py install for mozfile 04:37:00 INFO - Running setup.py install for mozhttpd 04:37:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Running setup.py install for mozinfo 04:37:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Running setup.py install for mozInstall 04:37:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Running setup.py install for mozleak 04:37:00 INFO - Running setup.py install for mozlog 04:37:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:00 INFO - Running setup.py install for moznetwork 04:37:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:01 INFO - Running setup.py install for mozprocess 04:37:01 INFO - Running setup.py install for mozprofile 04:37:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:01 INFO - Running setup.py install for mozrunner 04:37:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:01 INFO - Running setup.py install for mozscreenshot 04:37:01 INFO - Running setup.py install for moztest 04:37:01 INFO - Running setup.py install for mozversion 04:37:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:01 INFO - Cleaning up... 04:37:01 INFO - Return code: 0 04:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:01 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 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:37:01 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 04:37:01 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 04:37:01 INFO - Using env: {'DISPLAY': ':0', 04:37:01 INFO - 'HOME': '/home/cltbld', 04:37:01 INFO - 'LANG': 'en_US.UTF-8', 04:37:01 INFO - 'LANGUAGE': 'en_US:en', 04:37:01 INFO - 'LOGNAME': 'cltbld', 04:37:01 INFO - 'MAIL': '/var/mail/cltbld', 04:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:01 INFO - 'MOZ_NO_REMOTE': '1', 04:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:01 INFO - 'NO_EM_RESTART': '1', 04:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:01 INFO - 'PWD': '/builds/slave/test', 04:37:01 INFO - 'SHELL': '/bin/bash', 04:37:01 INFO - 'SHLVL': '1', 04:37:01 INFO - 'TERM': 'linux', 04:37:02 INFO - 'TMOUT': '86400', 04:37:02 INFO - 'USER': 'cltbld', 04:37:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:02 INFO - '_': '/tools/buildbot/bin/python'} 04:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:02 INFO - Running setup.py (path:/tmp/pip-WbN_C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:02 INFO - Running setup.py (path:/tmp/pip-NJqpOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:02 INFO - Running setup.py (path:/tmp/pip-PqB5W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:02 INFO - Running setup.py (path:/tmp/pip-GcXXkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:02 INFO - Running setup.py (path:/tmp/pip-DHXcSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:02 INFO - Running setup.py (path:/tmp/pip-WyjcvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:02 INFO - Running setup.py (path:/tmp/pip-ahc1KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:02 INFO - Running setup.py (path:/tmp/pip-jaumwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:02 INFO - Running setup.py (path:/tmp/pip-DCyIXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:02 INFO - Running setup.py (path:/tmp/pip-orN27t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:02 INFO - Running setup.py (path:/tmp/pip-pKq88G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:02 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)) 04:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:03 INFO - Running setup.py (path:/tmp/pip-Mk2e2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:03 INFO - Running setup.py (path:/tmp/pip-9Gvlci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:03 INFO - Running setup.py (path:/tmp/pip-EY3_48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:03 INFO - Running setup.py (path:/tmp/pip-dlxUwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:03 INFO - Running setup.py (path:/tmp/pip-xhWbMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:03 INFO - Running setup.py (path:/tmp/pip-m7Iyga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:03 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)) 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:03 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)) 04:37:03 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:37:03 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:37:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:03 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 04:37:03 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 04:37:03 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 04:37:03 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 04:37:03 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 04:37:03 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 04:37:04 INFO - Downloading blessings-1.6.tar.gz 04:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:05 INFO - Installing collected packages: blessings 04:37:05 INFO - Running setup.py install for blessings 04:37:05 INFO - Successfully installed blessings 04:37:05 INFO - Cleaning up... 04:37:05 INFO - Return code: 0 04:37:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:05 INFO - Reading from file tmpfile_stdout 04:37:05 INFO - Current package versions: 04:37:05 INFO - argparse == 1.2.1 04:37:05 INFO - blessings == 1.6 04:37:05 INFO - blobuploader == 1.2.4 04:37:05 INFO - docopt == 0.6.1 04:37:05 INFO - functools32 == 3.2.3-2 04:37:05 INFO - jsonschema == 2.5.1 04:37:05 INFO - manifestparser == 1.1 04:37:05 INFO - mozInstall == 1.12 04:37:05 INFO - mozcrash == 1.0 04:37:05 INFO - mozdebug == 0.1 04:37:05 INFO - mozdevice == 0.50 04:37:05 INFO - mozfile == 1.2 04:37:05 INFO - mozhttpd == 0.7 04:37:05 INFO - mozinfo == 0.9 04:37:05 INFO - mozleak == 0.1 04:37:05 INFO - mozlog == 3.4 04:37:05 INFO - moznetwork == 0.27 04:37:05 INFO - mozprocess == 0.25 04:37:05 INFO - mozprofile == 0.28 04:37:05 INFO - mozrunner == 6.13 04:37:05 INFO - mozscreenshot == 0.1 04:37:05 INFO - mozsystemmonitor == 0.3 04:37:05 INFO - moztest == 0.8 04:37:05 INFO - mozversion == 1.4 04:37:05 INFO - psutil == 3.1.1 04:37:05 INFO - requests == 1.2.3 04:37:05 INFO - wsgiref == 0.1.2 04:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:05 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 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:37:05 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 04:37:05 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 04:37:05 INFO - Using env: {'DISPLAY': ':0', 04:37:05 INFO - 'HOME': '/home/cltbld', 04:37:05 INFO - 'LANG': 'en_US.UTF-8', 04:37:05 INFO - 'LANGUAGE': 'en_US:en', 04:37:05 INFO - 'LOGNAME': 'cltbld', 04:37:05 INFO - 'MAIL': '/var/mail/cltbld', 04:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:05 INFO - 'MOZ_NO_REMOTE': '1', 04:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:05 INFO - 'NO_EM_RESTART': '1', 04:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:05 INFO - 'PWD': '/builds/slave/test', 04:37:05 INFO - 'SHELL': '/bin/bash', 04:37:05 INFO - 'SHLVL': '1', 04:37:05 INFO - 'TERM': 'linux', 04:37:05 INFO - 'TMOUT': '86400', 04:37:05 INFO - 'USER': 'cltbld', 04:37:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:05 INFO - '_': '/tools/buildbot/bin/python'} 04:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 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)) 04:37:05 INFO - Cleaning up... 04:37:05 INFO - Return code: 0 04:37:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', '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 04:37: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', 'jsonschema'] in /builds/slave/test/build 04:37: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 jsonschema 04:37:05 INFO - Using env: {'DISPLAY': ':0', 04:37:05 INFO - 'HOME': '/home/cltbld', 04:37:05 INFO - 'LANG': 'en_US.UTF-8', 04:37:05 INFO - 'LANGUAGE': 'en_US:en', 04:37:05 INFO - 'LOGNAME': 'cltbld', 04:37:05 INFO - 'MAIL': '/var/mail/cltbld', 04:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:05 INFO - 'MOZ_NO_REMOTE': '1', 04:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:05 INFO - 'NO_EM_RESTART': '1', 04:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:05 INFO - 'PWD': '/builds/slave/test', 04:37:05 INFO - 'SHELL': '/bin/bash', 04:37:05 INFO - 'SHLVL': '1', 04:37:05 INFO - 'TERM': 'linux', 04:37:05 INFO - 'TMOUT': '86400', 04:37:05 INFO - 'USER': 'cltbld', 04:37:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:05 INFO - '_': '/tools/buildbot/bin/python'} 04:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:06 INFO - Cleaning up... 04:37:06 INFO - Return code: 0 04:37:06 INFO - Running post-action listener: _resource_record_post_action 04:37:06 INFO - Running post-action listener: _start_resource_monitoring 04:37:06 INFO - Starting resource monitoring. 04:37:06 INFO - [mozharness: 2017-05-11 11:37:06.147004Z] Finished create-virtualenv step (success) 04:37:06 INFO - [mozharness: 2017-05-11 11:37:06.147523Z] Running install step. 04:37:06 INFO - Running pre-action listener: _resource_record_pre_action 04:37:06 INFO - Running main action method: install 04:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:06 INFO - Reading from file tmpfile_stdout 04:37:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:06 INFO - Reading from file tmpfile_stdout 04:37:06 INFO - Output received: 04:37:06 INFO - Usage: mozinstall [options] installer 04:37:06 INFO - Options: 04:37:06 INFO - -h, --help show this help message and exit 04:37:06 INFO - -d DEST, --destination=DEST 04:37:06 INFO - Directory to install application into. [default: 04:37:06 INFO - "/builds/slave/test"] 04:37:06 INFO - --app=APP Application being installed. [default: firefox] 04:37:06 INFO - mkdir: /builds/slave/test/build/application 04:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:37:23 INFO - Reading from file tmpfile_stdout 04:37:23 INFO - Output received: 04:37:23 INFO - /builds/slave/test/build/application/firefox/firefox 04:37:23 INFO - Running post-action listener: _resource_record_post_action 04:37:23 INFO - [mozharness: 2017-05-11 11:37:23.511933Z] Finished install step (success) 04:37:23 INFO - [mozharness: 2017-05-11 11:37:23.512212Z] Running run-tests step. 04:37:23 INFO - Running pre-action listener: _resource_record_pre_action 04:37:23 INFO - Running main action method: run_tests 04:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:23 INFO - Python 2.7.3 04:37:23 INFO - Return code: 0 04:37:23 INFO - grabbing minidump binary from tooltool 04:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:23 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 0x2241a30>, '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 0x22427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:23 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 04:37:23 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 04:37:23 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 04:37:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:23 INFO - Return code: 0 04:37:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:37:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:23 INFO - ENV: RUST_BACKTRACE is now 1 04:37:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:37:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:37:23 INFO - Using env: {'DISPLAY': ':0', 04:37:23 INFO - 'HOME': '/home/cltbld', 04:37:23 INFO - 'LANG': 'en_US.UTF-8', 04:37:23 INFO - 'LANGUAGE': 'en_US:en', 04:37:23 INFO - 'LOGNAME': 'cltbld', 04:37:23 INFO - 'MAIL': '/var/mail/cltbld', 04:37:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:23 INFO - 'MOZ_NO_REMOTE': '1', 04:37:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:23 INFO - 'NO_EM_RESTART': '1', 04:37:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:23 INFO - 'PWD': '/builds/slave/test', 04:37:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:23 INFO - 'RUST_BACKTRACE': '1', 04:37:23 INFO - 'SHELL': '/bin/bash', 04:37:23 INFO - 'SHLVL': '1', 04:37:23 INFO - 'TERM': 'linux', 04:37:23 INFO - 'TMOUT': '86400', 04:37:23 INFO - 'USER': 'cltbld', 04:37:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499', 04:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:23 INFO - '_': '/tools/buildbot/bin/python'} 04:37:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:37:23 INFO - mozversion application_buildid: 20170511104437 04:37:23 INFO - mozversion application_changeset: 86754a7acc0e12cf3c575e9867958c2bacc8f465 04:37:23 INFO - mozversion application_display_name: Nightly 04:37:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:23 INFO - mozversion application_name: Firefox 04:37:23 INFO - mozversion application_remotingname: firefox 04:37:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:37:23 INFO - mozversion application_vendor: Mozilla 04:37:23 INFO - mozversion application_version: 55.0a1 04:37:23 INFO - mozversion platform_buildid: 20170511104437 04:37:23 INFO - mozversion platform_changeset: 86754a7acc0e12cf3c575e9867958c2bacc8f465 04:37:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:37:23 INFO - mozversion platform_version: 55.0a1 04:37:23 INFO - using testdate: 1494502643 04:37:23 INFO - actual date: 1494502643 04:37:23 INFO - starting webserver on 'localhost:45431' 04:37:23 INFO - SUITE-START | Running 2 tests 04:37:23 INFO - TEST-START | dromaeo_css 04:37:23 INFO - operating with platform_type : linux_ 04:37:23 INFO - Initialising browser for dromaeo_css test... 04:37:23 INFO - TEST-INFO | started process 19898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaHlttO/profile http://localhost:45431/getInfo.html) 04:37:27 INFO - PID 19898 | __metrics Screen width/height:1600/1200 04:37:27 INFO - PID 19898 | colorDepth:24 04:37:27 INFO - PID 19898 | Browser inner width/height: 1024/695 04:37:27 INFO - PID 19898 | __metrics 04:37:28 INFO - PID 19898 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:37:28 INFO - PID 19898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:29 INFO - TEST-INFO | 19898: exit 0 04:37:29 INFO - Browser initialized. 04:37:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:29 INFO - TEST-INFO | started process 19995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaHlttO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:40 INFO - PID 19995 | RSS: Main: 144207872 04:37:40 INFO - PID 19995 | 04:40:43 INFO - PID 19995 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45431/tests/dromaeo/cssquery-ext.html) 04:40:45 INFO - PID 19995 | RSS: Main: 294871040 04:40:45 INFO - PID 19995 | 04:43:47 INFO - PID 19995 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-ext.html (next: http://localhost:45431/tests/dromaeo/cssquery-jquery.html) 04:43:47 INFO - PID 19995 | RSS: Main: 230350848 04:43:47 INFO - PID 19995 | 04:46:49 INFO - PID 19995 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45431/tests/dromaeo/cssquery-mootools.html) 04:46:49 INFO - PID 19995 | RSS: Main: 175124480 04:46:49 INFO - PID 19995 | 04:49:51 INFO - PID 19995 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45431/tests/dromaeo/cssquery-prototype.html) 04:49:52 INFO - PID 19995 | RSS: Main: 205488128 04:49:52 INFO - PID 19995 | 04:52:54 INFO - PID 19995 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45431/tests/dromaeo/cssquery-yui.html) 04:52:55 INFO - PID 19995 | RSS: Main: 177418240 04:52:55 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-yui.html (next: http://localhost:45431/tests/dromaeo/cssquery-dojo.html) 04:55:57 INFO - PID 19995 | RSS: Main: 272482304 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | __start_tp_report 04:55:57 INFO - PID 19995 | _x_x_mozilla_page_load 04:55:57 INFO - PID 19995 | _x_x_mozilla_page_load_details 04:55:57 INFO - PID 19995 | |i|pagename|runs| 04:55:57 INFO - PID 19995 | |0;dojo.html;3278.2296160402307;3317.452620317648;3322.1528510229887;3336.182635254363;3374.358871814355;5745;5859.44335288148;5911.704414779255;5920.378360272169;5945.7027148642555;5824.650520968745;5880.558958078151;5891.499222566087;5898.88202235955;5978.252718410199;5196.1166601677805;5199.038177937075;5226.216067589854;5260.658057226287;5264.42091369951;5220.216967454874;5305.575553955674;5342.412334643186;5347.893042139155;5349.358077030762;5286.312779338661;5361.142217245241;5364.356277246717;5401.810936617219;5407.918881216785;5123.257127716498;5162.896742065138;5185.896282074337;5213.2701421800975;5263.236830659571;5229.2156176573435;5245.86885327866;5256.342957130359;5278.868028299285;5307.389650190239;5832.795852145197;5865.677387743673;5875.735591898375;5885.323187833411;5892.116182572606;6173.845653858644;6283.434490895841;6405.423511883906;6410.166678331833;6414.550981431302;6366.586171898812;6385.904211436832;6425.45383642391;6430.485561155143;6490.675466226669;5945.227120474311;5948.226730525004;5953.940460595382;5986.850328741729;6002.819915402545;6380.808575742735;6516.348365163446;6517.217933847874;6572.572782769104;6577.934220657828;6190.1952746142715;6231.189945307081;6237.968810156011;6292.874142517216;6315.621062736251;6443.194600674916;6447.323031081763;6450.516211284079;6452.451541619015;6461.030845373231;6351.333110023381;6407.231132264158;6408.775692850728;6414.262359828586;6415.037744338293;6179.3202747697715;6250.6874656267;6280.811575652738;6340;6424.453921416732;4784.976075119602;4786.569208771228;4792.041591681677;4794.328793968847;4814.325994360793;4258.574142585717;4259.5527469615245;4261.509926358446;4297.591728785823;4312.180685669713;5849.766009359578;5982;5983.760649574056;5990.251218597676;6005.099235114681;6442.903356449657;6445.065465507569;6460.3862633049785;6464.806055818239;6466.805995820039;6010.609310394811;6036.728347224385;6045.667488288186;6056.121862329937;6057.212562366864;5440;5537.307836520435;5576.414476479911;5580.302462192226;5624.887502249932;6446.774362897276;6544.9672751635935;6587.275399705933;6593.637349945703;6602.900956485752;6346.587471814318;6442.774502892376;6443.96778016107;6448.29068802422;6456.709448074942;6457.0637257596445;6467.708953097216;6588.07766912623;6632.602043877383;6744.291849355747;6338.524610654312;6346.333634968262;6347.968260158855;6348.523860710373;6353.142325786144;6377.585456945284;6392.0731493934045;6394.6482943436695;6395.232572091379;6433.903491447726;6112.969435152796;6144.446999769863;6158.137860699416;6182.258129024546;6244.781432649836;6198.101275315144;6206.503479721701;6218.5647004709235;6245;6248.875022499616;6162.921488739363;6165.198524191826;6196.659183744938;6204.751809927733;6207.534434917489;6143.232095988002;6159.23009623797;6171.84570385744;6270.937290627217;6296.307406185408;6114.7536090578;6120.782376608402;6141.025769127022;6142.324344322032;6150.477209437069 04:55:57 INFO - PID 19995 | |1;ext.html;754.1176823116953;823.0575990490887;839.680921249925;1144.5593446523087;1160.3675996581862;30552.541711874313;38385.80807095964;39346.80326598363;39444.605553944486;39470.40794388079;41329;41473.58526414735;41686.79156604213;41738.79130604343;41757.58242417575;5731.656100633975;5855.121731740252;7207.24323945986;7325.743598974037;7347.742829000986;7216.567005979632;7385.076865391826;7388;7396.704131834747;7397.853332733435;7444.851102977965;7530.58581778002;7535.284148005931;7535.5478671279625;7547.43394245431;7436.330730234278;7473.439492038092;7488.288612581796;7492.550446973145;7505.549667019996;7337.3763230125505;7396;7399.186089530147;7399.260073992557;7401.555906645618;36381.81809090938;36469.270614587556;36593.63406365929;36609.26781464383;36615.63384366175;3513.54323937889;3549.893503194908;3550.2721942001826;3551.183227857607;3551.3074950384685;28459.146225613058;28542.857285713646;28646.570301445496;28652.570211446844;28705.425891482053;3653.488511608377;3660.432632941898;3675.503806986076;3698.3712768829364;3706.1475860552223;187241;189402.58961155938;189762;190019;190723;47608;47788.7610561945;47845.65080444336;47856.282155767694;47952.52047479481;50082.49917500851;50151.24773128406;50161;50163.24755128676;50202.74898625483;13272.800907986388;13342.466301348031;13358.131721438076;13373.732525349438;13374.33128343579;9415.952920235492;9575;10254.230932680079;10272.075513203847;11035.39305338214;13270.668233294246;13323.800142997863;13367.598972030855;13495.190288582717;13541;5444.292242008513;5465.344158700981;5491.945080549143;5496.367917689437;5509.090999984957;1074.4949873559415;1110.9224052668899;1121.4448847820217;1124.089487515099;1125.234840308598;26006;26156.869215653798;26335.473290534082;26366.86816565905;26432.339191520365;1201.7776711308436;1209.7580483903255;1211.6425654431964;1214.5566868093083;1226.4480983557435;13216.207027578184;13459.327033648278;13542.187468751907;13602.93198534001;13686.65783355424;220051;220840;220955;221555;222503;52567.73716131395;52591.73704131455;52608.73695631574;52623.21065184025;52714;1445.580781573332;1500.3098574655562;1522.1932375840822;1525.2907398059956;1529.8852586055868;23959.640605391283;25075.623865642396;25305.493890122463;25336.493270134863;25468.108616198344;38667;39058.21883562256;39072.2185556293;39106.6089339103;39131;200546;201342;201864;202102;202422;29662.258443539085;30206.54690179693;33765.493517597744;33861.49207761935;33887.15282117967;39755;41514.962125947095;41679.1664166721;42187;42304.78847605742;27359.179224623294;28469;28612.713872861004;29259.920634920636;29482.410351792416;28904.277393065342;28949.855250723613;29505.704942950295;30109.548356774227;30311.696883030887;34973;35450.11374715653;35623.64376356307;35828.462573060904;35959.10102247465;27926.72073279241;27978.860105699343;28500.287492812844;28636.284092897844;29336;23763.762362376154;24693.62959555572;24805.875970620033;24842.50314993654;25117.120900769118 04:55:57 INFO - PID 19995 | |2;jquery.html;437.3046855499756;443.1358850242029;445.67911104005105;463.2888516127744;467.1288047790869;19179.712304315428;20194.495137621547;20868.582628347423;20933.68599471007;20981;21153.894230528866;21354.893225533888;21371.6794248086;22148.778512214874;23306.06775728973;5429.239906413095;5590.413006634306;5605.467480589358;5607.607467477278;5607.719614019283;5455.727213639322;5568.888622227553;5619.522340601054;5690.317161940573;5748.97125514374;5569.637973531728;5593;5593.664380137185;5596.916046259309;5618.91571626426;5369.973150134244;5622.409646987069;5647.830565083054;5669.9433005669825;5679.432056794329;5046.495350464961;5153.0466863630345;5156.871078223037;5164.741762911877;5164.8967020659375;24827.87586062058;25091.62362564563;25124.623130653054;25353.87323063391;25467.61798573023;2142.7964343387353;2187.147012665062;2188.7592364839857;2192.583409152256;2193.8354623403307;15200.695986080327;15559.22203889801;15645.452409165624;15713.842861571353;15804.446844360507;2133.967990480144;2145.3159269973;2174.4889950861534;2191.0687957617947;2211.579799838026;89799;102901.4854925728;109038;109178.45410772895;110241;12476.875231247572;12680.175788573713;12730.681732956566;12844.229346239255;12850.614481565568;17709.468715938543;17742.822571774115;17840.732389014174;17900.91049544744;17954.102294885204;8844.867326990101;8898.955505222433;8937.687180948766;9032.36773425854;9203;8266.13205613414;8279.130691277329;8527.701530446404;8534.402591818513;8573.957130214309;7841.568713720686;7940.920590794018;8165.305948994283;8287.917120828835;8341.24928756415;2136.7863213678506;2166.166026079939;2190.1896298369707;2201.8678879267295;2279.452931296477;1023.3706270643501;1031.2265800649513;1037.9481025948671;1040.5005597313332;1045.1482042135635;20010.29963951255;21721.239756608444;23127.653085203397;25701;25892.352691182496;1043.1341986151476;1049.1554298789547;1051.222095649214;1063.7021633942509;1072.2815713471837;10957.945210273898;11411;11581.536738530533;11640.94179529097;11708.941455292668;486230;489651;491566;493201;498717;89723;90183.54908225418;91151.54424227969;91248.54375728211;92281;1234.4321612058554;1250.4623012104882;1280.0271793436868;1284.877936596022;1286.2861112082696;17781.73327400116;17866.91066544659;17935.461936141935;18269.54326141857;18442.170102345157;45216.54783452255;45353.546464534935;45882.311765324215;46616.7669161652;46817.76591117022;57988;58348.12477812921;58420.415795841494;58610.413895860496;59196.70401647964;8902;8929.419587726778;9178;9288.071192880929;9320.300977426585;13625.182489050689;13740.175589464265;13843;13851.584452466443;14169.645758856112;11855.288682679067;12552.686182845136;12598.496060157491;12808.871911281141;12819.013052976803;10928.180386470887;11085.778284434427;11211.9348661877;11377.2604780689;11486.483108259981;12264;12352.197107188003;12494.125411221126;12799.232046077264;13544.864551354754;9094.59074341643;9108.225800807006;9234.076592340713;9455.676205331121;9463.2429405646;11199.496022678835;12069.215500992408;12152;12395.132340736061;12952.481900723866 04:55:57 INFO - PID 19995 | |3;mootools.html;1330.8336457942758;1377.2562816079317;1385.854485279045;1387.1954266525415;1395.6301580081276;10712.143028557715;11192;11196.160287978393;11198.608048718297;11198.776024479515;10830.296030757996;10998.505067271972;11367.431628418588;11379.943100284487;11388.658340249805;2347.3779448446135;2377.8097752179783;2377.9167729129485;2379.5003049359657;2384.654225137354;1953.3982134649593;2221.278084622496;2284.246198754415;2284.4579908561736;2285.8228012573454;2009.1159889648582;2167.5773224221284;2285.451491642002;2299.057386471547;2301.022065622112;2276.055436993646;2283.22370394066;2294.6902168207243;2295.1507942061376;2296.9893246971446;2246.483308838976;2254.2786308381324;2271.057511132878;2321.442853715096;2329.650552417134;11076.667699969013;11112.666480022368;11162.776744465147;11164.441777911072;11187.32876027441;6265.780697675605;6510.381513756186;6516.706748196342;6523.18460192476;6537.496375833585;3733.5706393764794;3929.135590170158;4065.227606754737;4094.078832262747;4123.752574845489;1304.4912484131196;1313.9211647301192;1337.0774165825646;1368.3773882883265;1376.6833628265456;16257.918710406373;16418.17909104552;16444.6711065778;16458.83541164597;16467.917660411742;5259.789608415621;5272.182811664198;5347.304850369427;5350.732463376816;5492.945070549324;12120.63638090841;12163.087768417405;12171.513139474499;12184.08619353552;12193.146479746332;6492.707828147744;6494.805155845333;6498.3826536478955;6500.447461965691;6504.902426463606;5617.634853734494;5726.169705392695;5795.797147099831;6123.958926982424;6129.601575897553;4185.832566697298;4302.82788688449;4338.934915976263;4339.804708788112;4378.387025816388;1184.2124986883798;1233.1244816180433;1240.107122871549;1255.6609715376796;1258.6790368456168;758.1963119093779;865.2904618213131;880.2429910277157;884.2263019857625;894.5571941888807;6216.285127210429;6285;6367.808965731036;6503.6097834130105;6585.374389432996;949;963.6675347005412;978.8580655804868;984.5274268351232;1002.774375765447;4096.40602112692;4122.814473348706;4134.24294674762;4149.668026557868;4151.045259590311;14732.705345893022;15133.167675777939;15135.016223945408;15141.772873406908;15254.847451525564;14390.28048597566;14897.180655064076;14908.329125189393;14908.62728431798;15104.773428398583;8882.555872206363;9108.089191080839;9137.40606860552;9171.81656366869;9196.816063678689;6734.653069386044;7239.8914016290855;7288.271172882669;7362.9631851840395;7370.410367170721;12588.118831681695;12834.935825320814;13132.934335328262;13167.67080822987;13233.669158271121;13140.60578182656;13151.34243287851;13154;13161.868381316448;13511.459541618226;10294.588216471557;10458.215633827342;10586.417747023988;10593.364398136137;10596.152307815202;10110.140638045554;10354.844677329997;10469.581216751549;10804.519615972495;10818.459077045958;7480.588567628833;8689.47863128189;9066.456012639263;9137.223336016514;9294.302927280345;8779.165979231962;8976.910230897607;8998.14517620825;9128.406653567497;9288.535573221177;8468.068512463748;8640.697575584825;8653.913460865311;8657;8659.48043117415;6089.360617135137;6111.755529778759;6132.2947860996555;6164.6917654118015;6284.4972402206795;6370.968145159244;6457.418832305115;6471.482281417381;6585.80242592723;6753.831154221184 04:55:57 INFO - PID 19995 | |4;prototype.html;391.2018320640257;397.67390739593526;414.52536845312113;415.1261594343904;417.0722908832147;5895.557833162514;5916.674582897939;5918.763249470021;5922.2597175353085;5926.49624781893;5601.8599535011645;5739.483446489815;5762.827115186541;5798.942010579893;5824.941750582493;4393.582609652094;4404.4054052702795;4411.250087485119;4425.7565833879125;4431.512533621315;4414.249577571804;4417.933730994037;4428.782084926639;4442.378067070613;4451.821927122911;4345.196138714332;4369.104333611618;4375.67182461315;4410.911781764379;4415.315626077963;4357.629601483894;4362.389265502817;4364.236258654722;4385.605295523418;4397.670174736875;3844.519435070616;3850.6919446444217;3857.498525191707;3869.438931354966;3872.206197729459;5547.5007249347345;5625.240592519998;5634.943650563524;5638.548916086703;5679.772809087673;5145.819896303611;5146.562542183881;5152.639315247934;5153.330067091291;5164.354455693038;6016.368281330441;6153.569250152491;6156.322804491502;6172.84567885802;6219.564630475868;4266.717306241146;4309.181255561464;4312.8490502832565;4328.264195086843;4331.436913201295;6213.1922850029205;6272.18461599989;6317.273513545909;6401.263854656728;6513.706883190221;4392.38506609075;4398.912021759547;4402.3836662867225;4403.185410699031;4425.468943726709;4493.191225579427;4493.370928070073;4494.415725955605;4494.797734101973;4504.572065653758;5095.847124586268;5137.922931156036;5185.144451165515;5193.974030129901;5199.610029247821;6175.722092505848;6177;6178.165947597017;6187.535934804908;6201.720922558496;1497.91012539248;1532.8926975111635;1539.661274519604;1540.091346105803;1544.3282172255106;1014.3812274512542;1028.909356082555;1032.9793404131876;1037.2065369991963;1038.4651904269308;5981.192539007266;5984.670843103584;6002.219711437485;6011.489023433057;6033.5173186145;6261.592996455216;6268.749250030039;6376.936230637727;6396.872062558723;6408.231012278557;5989.371116032841;6005.159277701126;6027.939720602825;6028.4272994065495;6037.335893051761;3354.8322583871195;3354.865805367807;3368.612609549884;3371.511130886057;3383.3233353329433;6437.452816510556;6719.832004199837;6737.865242695217;6742.190937087581;6753.223379311344;6549.0176473529355;6571.047198156336;6578.309277525791;6578.618490117129;6599.1091202687985;6629.469642428594;6692.498062645321;6750.122484077038;6781.254062053072;6790.898136527956;6431.260405053479;6440.549161558646;6449.3873082057125;6451.774187903401;6456.483481321577;6093.939060609515;6220.782272620437;6303.2120984875055;6357.315311442564;6384.553081284265;6533.379328963741;6590.637514936533;6675.432588229861;6706.865862682816;6737.562058466184;4399.6920215584605;4400.669949753717;4409.7354158749295;4420.933685994648;4436.778161091868;6277.654728989949;6349.809505714836;6429.4856411486035;6436.613803171825;6438.420542151229;6196.504279657706;6198.442140207403;6216.751329946752;6221.626702397871;6249.593776404519;6094.878102437838;6131.754729810757;6147.96926015385;6198.132261483486;6244.250689917239;6187.969060154851;6201.937980620136;6213.726186131742;6227.96886015567;6230.127782110418;6099.756009759737;6254.687265636791;6256.937430625636;6277.780277690259;6296.590721603081;6058.151858739868;6101.877962440815;6105.504151482915;6112.17485639433;6117.204763380732 04:55:57 INFO - PID 19995 | |5;yui.html;861.9396642235046;874.4141425245085;877.1053525404088;878.1745159550022;887.378834815629;15904.125273109974;16295;16410.34358625655;16414.09722465264;16434.589135271624;16414;16574.254158562864;16623.251953662086;16634.66730665389;16665.333386664548;989.159214667534;996.9950150249239;1008.0473952115254;1010.2120346129993;1011.3375738891039;1043.2801367056707;1045.1743122932874;1045.8117538843005;1046.0533217438192;1046.6755305855172;1068.1775033224412;1079.0450451350532;1079.20139097068;1079.4872435593109;1080.0819303591963;1075.1936047964027;1075.2150929821196;1077.9353238805656;1080.2384319055047;1081.1026847716375;789.3645615279697;789.9012623422072;790.095340834741;790.4229912164095;790.5809920741958;17250.482485525456;17397.826021739747;17408.390706325343;17662.735058974125;17858.196381162878;18436.262549498137;18764.249430022785;18875;18983.145758440765;19190.52023699405;14419;14870.182139982297;15038.624034399118;15052.32264548098;15062.849371506254;3234.886778962725;3348.961821835239;3385.221399078201;3400.2009527760956;3403.5745531808525;77336;77744.22255777483;78735;79315.60342198309;80298;14188.645283867985;14524.854751452562;14671.826253899875;14687.485937992333;14689.706205875822;25021.62467562988;26363.73636263651;26989.325266868094;27023.45953080967;27043;8334.374921880883;8527.872081918777;8539.359548033923;8540.231379175904;8563.614637341334;4042.3532234842282;4107.322291821875;4131.442255295497;4133.173365326947;4134.421181034658;5013.448520662724;5139.254808052811;5142.6400151989;5146.845594632092;5185.481451854785;971.7862070344513;977.130353984954;979.3389462113046;992.8858181309242;997.4563862694848;711.6477343714894;714.5426926766874;730.6273800361854;736.6758626204453;752.3604935804632;11680.299182049104;12427.192232504858;12523.93738031304;12746.553870614669;12818.102732808615;724.051492544768;729.6971756721008;731.989020164698;736.006391371644;739.981500462482;5414;5421.322334708161;5795.478406943395;5861.824145275648;6059.242594675666;72258.2774172262;74442.62778686071;75906;77424;83513.58243208866;60650.09024864631;60667;63204.68397657982;64789;66670.66664666646;61140;61893;62126.378736212966;62178;62816.685916570124;11590.188686791844;12509.74980500403;12739.56031871371;12911.35443227816;13073.673158171121;31648.841755791073;32328.676713232566;32329.35341293208;33251.99999999903;33428.997130086136;54246.45753542572;54745.1788223169;55788.72105639446;56309.155362668775;57120.71439642775;15234;15485.612859678598;15500;15566.688666226839;15684.76472852931;17702.645947080728;17976;18052.638947221243;18122.72815907736;18135.27458901629;15956.840431595536;16467.835321647108;16706.4152754653;17288.567785804953;17438;16327.673446530765;17026.404075857285;17045.16509257253;17057.744133837754;17233.91383043127;16342.428015019417;16862;17041.147942603067;17068.573285667957;17283.481495555152;11855.229410088317;12208.938955305166;12219;12343.629691109281;12633.305168215837;13327.267000315076;13808;13844;14035.877129829792;14046.508372206923 04:55:57 INFO - PID 19995 | __end_tp_report 04:55:57 INFO - PID 19995 | __start_cc_report 04:55:57 INFO - PID 19995 | _x_x_mozilla_cycle_collect,1585 04:55:57 INFO - PID 19995 | __end_cc_report 04:55:57 INFO - PID 19995 | __startTimestamp1494503757501__endTimestamp 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | ------- Summary: start ------- 04:55:57 INFO - PID 19995 | Number of tests: 6 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | [#0] dojo.html Cycles:165 Average:5887.12 Median:6150.48 stddev:713.48 (11.6%) stddev-sans-first:685.69 04:55:57 INFO - PID 19995 | Values: 3278.2 3317.5 3322.2 3336.2 3374.4 5745.0 5859.4 5911.7 5920.4 5945.7 5824.7 5880.6 5891.5 5898.9 5978.3 5196.1 5199.0 5226.2 5260.7 5264.4 5220.2 5305.6 5342.4 5347.9 5349.4 5286.3 5361.1 5364.4 5401.8 5407.9 5123.3 5162.9 5185.9 5213.3 5263.2 5229.2 5245.9 5256.3 5278.9 5307.4 5832.8 5865.7 5875.7 5885.3 5892.1 6173.8 6283.4 6405.4 6410.2 6414.6 6366.6 6385.9 6425.5 6430.5 6490.7 5945.2 5948.2 5953.9 5986.9 6002.8 6380.8 6516.3 6517.2 6572.6 6577.9 6190.2 6231.2 6238.0 6292.9 6315.6 6443.2 6447.3 6450.5 6452.5 6461.0 6351.3 6407.2 6408.8 6414.3 6415.0 6179.3 6250.7 6280.8 6340.0 6424.5 4785.0 4786.6 4792.0 4794.3 4814.3 4258.6 4259.6 4261.5 4297.6 4312.2 5849.8 5982.0 5983.8 5990.3 6005.1 6442.9 6445.1 6460.4 6464.8 6466.8 6010.6 6036.7 6045.7 6056.1 6057.2 5440.0 5537.3 5576.4 5580.3 5624.9 6446.8 6545.0 6587.3 6593.6 6602.9 6346.6 6442.8 6444.0 6448.3 6456.7 6457.1 6467.7 6588.1 6632.6 6744.3 6338.5 6346.3 6348.0 6348.5 6353.1 6377.6 6392.1 6394.6 6395.2 6433.9 6113.0 6144.4 6158.1 6182.3 6244.8 6198.1 6206.5 6218.6 6245.0 6248.9 6162.9 6165.2 6196.7 6204.8 6207.5 6143.2 6159.2 6171.8 6270.9 6296.3 6114.8 6120.8 6141.0 6142.3 6150.5 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | [#1] ext.html Cycles:180 Average:36728.59 Median:34430.08 stddev:53044.20 (154.1%) stddev-sans-first:53124.23 04:55:57 INFO - PID 19995 | Values: 754.1 823.1 839.7 1144.6 1160.4 30552.5 38385.8 39346.8 39444.6 39470.4 41329.0 41473.6 41686.8 41738.8 41757.6 5731.7 5855.1 7207.2 7325.7 7347.7 7216.6 7385.1 7388.0 7396.7 7397.9 7444.9 7530.6 7535.3 7535.5 7547.4 7436.3 7473.4 7488.3 7492.6 7505.5 7337.4 7396.0 7399.2 7399.3 7401.6 36381.8 36469.3 36593.6 36609.3 36615.6 3513.5 3549.9 3550.3 3551.2 3551.3 28459.1 28542.9 28646.6 28652.6 28705.4 3653.5 3660.4 3675.5 3698.4 3706.1 187241.0 189402.6 189762.0 190019.0 190723.0 47608.0 47788.8 47845.7 47856.3 47952.5 50082.5 50151.2 50161.0 50163.2 50202.7 13272.8 13342.5 13358.1 13373.7 13374.3 9416.0 9575.0 10254.2 10272.1 11035.4 13270.7 13323.8 13367.6 13495.2 13541.0 5444.3 5465.3 5491.9 5496.4 5509.1 1074.5 1110.9 1121.4 1124.1 1125.2 26006.0 26156.9 26335.5 26366.9 26432.3 1201.8 1209.8 1211.6 1214.6 1226.4 13216.2 13459.3 13542.2 13602.9 13686.7 220051.0 220840.0 220955.0 221555.0 222503.0 52567.7 52591.7 52608.7 52623.2 52714.0 1445.6 1500.3 1522.2 1525.3 1529.9 23959.6 25075.6 25305.5 25336.5 25468.1 38667.0 39058.2 39072.2 39106.6 39131.0 200546.0 201342.0 201864.0 202102.0 202422.0 29662.3 30206.5 33765.5 33861.5 33887.2 39755.0 41515.0 41679.2 42187.0 42304.8 27359.2 28469.0 28612.7 29259.9 29482.4 28904.3 28949.9 29505.7 30109.5 30311.7 34973.0 35450.1 35623.6 35828.5 35959.1 27926.7 27978.9 28500.3 28636.3 29336.0 23763.8 24693.6 24805.9 24842.5 25117.1 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | [#2] jquery.html Cycles:180 Average:30615.59 Median:2197.85 stddev:81456.71 (3706.2%) stddev-sans-first:81653.70 04:55:57 INFO - PID 19995 | Values: 437.3 443.1 445.7 463.3 467.1 19179.7 20194.5 20868.6 20933.7 20981.0 21153.9 21354.9 21371.7 22148.8 23306.1 5429.2 5590.4 5605.5 5607.6 5607.7 5455.7 5568.9 5619.5 5690.3 5749.0 5569.6 5593.0 5593.7 5596.9 5618.9 5370.0 5622.4 5647.8 5669.9 5679.4 5046.5 5153.0 5156.9 5164.7 5164.9 24827.9 25091.6 25124.6 25353.9 25467.6 2142.8 2187.1 2188.8 2192.6 2193.8 15200.7 15559.2 15645.5 15713.8 15804.4 2134.0 2145.3 2174.5 2191.1 2211.6 89799.0 102901.5 109038.0 109178.5 110241.0 12476.9 12680.2 12730.7 12844.2 12850.6 17709.5 17742.8 17840.7 17900.9 17954.1 8844.9 8899.0 8937.7 9032.4 9203.0 8266.1 8279.1 8527.7 8534.4 8574.0 7841.6 7940.9 8165.3 8287.9 8341.2 2136.8 2166.2 2190.2 2201.9 2279.5 1023.4 1031.2 1037.9 1040.5 1045.1 20010.3 21721.2 23127.7 25701.0 25892.4 1043.1 1049.2 1051.2 1063.7 1072.3 10957.9 11411.0 11581.5 11640.9 11708.9 486230.0 489651.0 491566.0 493201.0 498717.0 89723.0 90183.5 91151.5 91248.5 92281.0 1234.4 1250.5 1280.0 1284.9 1286.3 17781.7 17866.9 17935.5 18269.5 18442.2 45216.5 45353.5 45882.3 46616.8 46817.8 57988.0 58348.1 58420.4 58610.4 59196.7 8902.0 8929.4 9178.0 9288.1 9320.3 13625.2 13740.2 13843.0 13851.6 14169.6 11855.3 12552.7 12598.5 12808.9 12819.0 10928.2 11085.8 11211.9 11377.3 11486.5 12264.0 12352.2 12494.1 12799.2 13544.9 9094.6 9108.2 9234.1 9455.7 9463.2 11199.5 12069.2 12152.0 12395.1 12952.5 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | [#3] mootools.html Cycles:180 Average:7074.73 Median:2338.51 stddev:4487.43 (191.9%) stddev-sans-first:4479.26 04:55:57 INFO - PID 19995 | Values: 1330.8 1377.3 1385.9 1387.2 1395.6 10712.1 11192.0 11196.2 11198.6 11198.8 10830.3 10998.5 11367.4 11379.9 11388.7 2347.4 2377.8 2377.9 2379.5 2384.7 1953.4 2221.3 2284.2 2284.5 2285.8 2009.1 2167.6 2285.5 2299.1 2301.0 2276.1 2283.2 2294.7 2295.2 2297.0 2246.5 2254.3 2271.1 2321.4 2329.7 11076.7 11112.7 11162.8 11164.4 11187.3 6265.8 6510.4 6516.7 6523.2 6537.5 3733.6 3929.1 4065.2 4094.1 4123.8 1304.5 1313.9 1337.1 1368.4 1376.7 16257.9 16418.2 16444.7 16458.8 16467.9 5259.8 5272.2 5347.3 5350.7 5492.9 12120.6 12163.1 12171.5 12184.1 12193.1 6492.7 6494.8 6498.4 6500.4 6504.9 5617.6 5726.2 5795.8 6124.0 6129.6 4185.8 4302.8 4338.9 4339.8 4378.4 1184.2 1233.1 1240.1 1255.7 1258.7 758.2 865.3 880.2 884.2 894.6 6216.3 6285.0 6367.8 6503.6 6585.4 949.0 963.7 978.9 984.5 1002.8 4096.4 4122.8 4134.2 4149.7 4151.0 14732.7 15133.2 15135.0 15141.8 15254.8 14390.3 14897.2 14908.3 14908.6 15104.8 8882.6 9108.1 9137.4 9171.8 9196.8 6734.7 7239.9 7288.3 7363.0 7370.4 12588.1 12834.9 13132.9 13167.7 13233.7 13140.6 13151.3 13154.0 13161.9 13511.5 10294.6 10458.2 10586.4 10593.4 10596.2 10110.1 10354.8 10469.6 10804.5 10818.5 7480.6 8689.5 9066.5 9137.2 9294.3 8779.2 8976.9 8998.1 9128.4 9288.5 8468.1 8640.7 8653.9 8657.0 8659.5 6089.4 6111.8 6132.3 6164.7 6284.5 6371.0 6457.4 6471.5 6585.8 6753.8 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | [#4] prototype.html Cycles:180 Average:5186.62 Median:5982.93 stddev:1571.61 (26.3%) stddev-sans-first:1534.25 04:55:57 INFO - PID 19995 | Values: 391.2 397.7 414.5 415.1 417.1 5895.6 5916.7 5918.8 5922.3 5926.5 5601.9 5739.5 5762.8 5798.9 5824.9 4393.6 4404.4 4411.3 4425.8 4431.5 4414.2 4417.9 4428.8 4442.4 4451.8 4345.2 4369.1 4375.7 4410.9 4415.3 4357.6 4362.4 4364.2 4385.6 4397.7 3844.5 3850.7 3857.5 3869.4 3872.2 5547.5 5625.2 5634.9 5638.5 5679.8 5145.8 5146.6 5152.6 5153.3 5164.4 6016.4 6153.6 6156.3 6172.8 6219.6 4266.7 4309.2 4312.8 4328.3 4331.4 6213.2 6272.2 6317.3 6401.3 6513.7 4392.4 4398.9 4402.4 4403.2 4425.5 4493.2 4493.4 4494.4 4494.8 4504.6 5095.8 5137.9 5185.1 5194.0 5199.6 6175.7 6177.0 6178.2 6187.5 6201.7 1497.9 1532.9 1539.7 1540.1 1544.3 1014.4 1028.9 1033.0 1037.2 1038.5 5981.2 5984.7 6002.2 6011.5 6033.5 6261.6 6268.7 6376.9 6396.9 6408.2 5989.4 6005.2 6027.9 6028.4 6037.3 3354.8 3354.9 3368.6 3371.5 3383.3 6437.5 6719.8 6737.9 6742.2 6753.2 6549.0 6571.0 6578.3 6578.6 6599.1 6629.5 6692.5 6750.1 6781.3 6790.9 6431.3 6440.5 6449.4 6451.8 6456.5 6093.9 6220.8 6303.2 6357.3 6384.6 6533.4 6590.6 6675.4 6706.9 6737.6 4399.7 4400.7 4409.7 4420.9 4436.8 6277.7 6349.8 6429.5 6436.6 6438.4 6196.5 6198.4 6216.8 6221.6 6249.6 6094.9 6131.8 6148.0 6198.1 6244.3 6188.0 6201.9 6213.7 6228.0 6230.1 6099.8 6254.7 6256.9 6277.8 6296.6 6058.2 6101.9 6105.5 6112.2 6117.2 04:55:57 INFO - PID 19995 | 04:55:57 INFO - PID 19995 | [#5] yui.html Cycles:180 Average:18453.77 Median:18929.07 stddev:21415.07 (113.1%) stddev-sans-first:21434.40 04:55:57 INFO - PID 19995 | Values: 861.9 874.4 877.1 878.2 887.4 15904.1 16295.0 16410.3 16414.1 16434.6 16414.0 16574.3 16623.3 16634.7 16665.3 989.2 997.0 1008.0 1010.2 1011.3 1043.3 1045.2 1045.8 1046.1 1046.7 1068.2 1079.0 1079.2 1079.5 1080.1 1075.2 1075.2 1077.9 1080.2 1081.1 789.4 789.9 790.1 790.4 790.6 17250.5 17397.8 17408.4 17662.7 17858.2 18436.3 18764.2 18875.0 18983.1 19190.5 14419.0 14870.2 15038.6 15052.3 15062.8 3234.9 3349.0 3385.2 3400.2 3403.6 77336.0 77744.2 78735.0 79315.6 80298.0 14188.6 14524.9 14671.8 14687.5 14689.7 25021.6 26363.7 26989.3 27023.5 27043.0 8334.4 8527.9 8539.4 8540.2 8563.6 4042.4 4107.3 4131.4 4133.2 4134.4 5013.4 5139.3 5142.6 5146.8 5185.5 971.8 977.1 979.3 992.9 997.5 711.6 714.5 730.6 736.7 752.4 11680.3 12427.2 12523.9 12746.6 12818.1 724.1 729.7 732.0 736.0 740.0 5414.0 5421.3 5795.5 5861.8 6059.2 72258.3 74442.6 75906.0 77424.0 83513.6 60650.1 60667.0 63204.7 64789.0 66670.7 61140.0 61893.0 62126.4 62178.0 62816.7 11590.2 12509.7 12739.6 12911.4 13073.7 31648.8 32328.7 32329.4 33252.0 33429.0 54246.5 54745.2 55788.7 56309.2 57120.7 15234.0 15485.6 15500.0 15566.7 15684.8 17702.6 17976.0 18052.6 18122.7 18135.3 15956.8 16467.8 16706.4 17288.6 17438.0 16327.7 17026.4 17045.2 17057.7 17233.9 16342.4 16862.0 17041.1 17068.6 17283.5 11855.2 12208.9 12219.0 12343.6 12633.3 13327.3 13808.0 13844.0 14035.9 14046.5 04:55:57 INFO - PID 19995 | -------- Summary: end -------- 04:55:57 INFO - PID 19995 | 04:55:58 INFO - TEST-INFO | 19995: exit 0 04:55:58 INFO - TEST-OK | dromaeo_css | took 1114509ms 04:55:58 INFO - TEST-START | kraken 04:55:58 INFO - operating with platform_type : linux_ 04:55:58 INFO - Initialising browser for kraken test... 04:55:58 INFO - TEST-INFO | started process 20327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPTAJao/profile http://localhost:45431/getInfo.html) 04:56:01 INFO - PID 20327 | __metrics Screen width/height:1600/1200 04:56:01 INFO - PID 20327 | colorDepth:24 04:56:01 INFO - PID 20327 | Browser inner width/height: 1024/695 04:56:01 INFO - PID 20327 | __metrics 04:56:02 INFO - PID 20327 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:02 INFO - PID 20327 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:03 INFO - TEST-INFO | 20327: exit 0 04:56:03 INFO - Browser initialized. 04:56:03 INFO - Running cycle 1/1 for kraken test... 04:56:03 INFO - TEST-INFO | started process 20428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPTAJao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:15 INFO - PID 20428 | RSS: Main: 144232448 04:56:15 INFO - PID 20428 | 04:56:17 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:18 INFO - PID 20428 | RSS: Main: 216662016 04:56:18 INFO - PID 20428 | 04:56:21 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-dft) 04:56:21 INFO - PID 20428 | RSS: Main: 177999872 04:56:21 INFO - PID 20428 | 04:56:24 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-fft) 04:56:25 INFO - PID 20428 | RSS: Main: 258228224 04:56:25 INFO - PID 20428 | 04:56:27 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-oscillator) 04:56:27 INFO - PID 20428 | RSS: Main: 169566208 04:56:27 INFO - PID 20428 | 04:56:30 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:30 INFO - PID 20428 | RSS: Main: 173076480 04:56:30 INFO - PID 20428 | 04:56:33 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45431/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:34 INFO - PID 20428 | RSS: Main: 230711296 04:56:34 INFO - PID 20428 | 04:56:37 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45431/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:38 INFO - PID 20428 | RSS: Main: 252768256 04:56:38 INFO - PID 20428 | 04:56:40 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45431/tests/kraken/driver.html?testName=json-parse-financial) 04:56:41 INFO - PID 20428 | RSS: Main: 266850304 04:56:41 INFO - PID 20428 | 04:56:42 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:43 INFO - PID 20428 | RSS: Main: 197844992 04:56:43 INFO - PID 20428 | 04:56:45 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:45 INFO - PID 20428 | RSS: Main: 202207232 04:56:45 INFO - PID 20428 | 04:56:47 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:48 INFO - PID 20428 | RSS: Main: 211365888 04:56:48 INFO - PID 20428 | 04:56:50 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:51 INFO - PID 20428 | RSS: Main: 220667904 04:56:51 INFO - PID 20428 | 04:56:54 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:55 INFO - PID 20428 | RSS: Main: 216330240 04:56:55 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45431/tests/kraken/driver.html?testName=ai-astar) 04:56:56 INFO - PID 20428 | RSS: Main: 266915840 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | __start_tp_report 04:56:56 INFO - PID 20428 | _x_x_mozilla_page_load 04:56:56 INFO - PID 20428 | _x_x_mozilla_page_load_details 04:56:56 INFO - PID 20428 | |i|pagename|runs| 04:56:56 INFO - PID 20428 | |0;ai-astar;108;110;109;109;109;110;109;108;110;110 04:56:56 INFO - PID 20428 | |1;audio-beat-detection;142;119;120;157;117;118;117;117;139;119 04:56:56 INFO - PID 20428 | |2;audio-dft;161;160;160;161;161;160;159;160;162;162 04:56:56 INFO - PID 20428 | |3;audio-fft;72;74;74;107;75;75;74;76;92;75 04:56:56 INFO - PID 20428 | |4;audio-oscillator;84;82;107;82;82;82;100;82;82;106 04:56:56 INFO - PID 20428 | |5;imaging-gaussian-blur;113;114;113;114;113;114;113;113;113;114 04:56:56 INFO - PID 20428 | |6;imaging-darkroom;146;146;146;148;147;147;147;147;148;148 04:56:56 INFO - PID 20428 | |7;imaging-desaturate;94;95;94;93;94;93;94;93;93;93 04:56:56 INFO - PID 20428 | |8;json-parse-financial;46;46;46;47;47;47;47;46;46;47 04:56:56 INFO - PID 20428 | |9;json-stringify-tinderbox;55;54;53;54;54;53;54;54;54;54 04:56:56 INFO - PID 20428 | |10;stanford-crypto-aes;79;79;78;79;80;78;78;86;80;78 04:56:56 INFO - PID 20428 | |11;stanford-crypto-ccm;127;125;124;123;123;123;121;121;173;126 04:56:56 INFO - PID 20428 | |12;stanford-crypto-pbkdf2;175;175;184;181;182;184;177;183;172;185 04:56:56 INFO - PID 20428 | |13;stanford-crypto-sha256-iterative;65;67;70;65;68;67;68;66;66;64 04:56:56 INFO - PID 20428 | __end_tp_report 04:56:56 INFO - PID 20428 | __start_cc_report 04:56:56 INFO - PID 20428 | _x_x_mozilla_cycle_collect,1697 04:56:56 INFO - PID 20428 | __end_cc_report 04:56:56 INFO - PID 20428 | __startTimestamp1494503816947__endTimestamp 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | ------- Summary: start ------- 04:56:56 INFO - PID 20428 | Number of tests: 14 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 04:56:56 INFO - PID 20428 | Values: 108.0 110.0 109.0 109.0 109.0 110.0 109.0 108.0 110.0 110.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#1] audio-beat-detection Cycles:10 Average:126.50 Median:119.50 stddev:14.24 (11.9%) stddev-sans-first:13.95 04:56:56 INFO - PID 20428 | Values: 142.0 119.0 120.0 157.0 117.0 118.0 117.0 117.0 139.0 119.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 04:56:56 INFO - PID 20428 | Values: 161.0 160.0 160.0 161.0 161.0 160.0 159.0 160.0 162.0 162.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#3] audio-fft Cycles:10 Average:79.40 Median:75.00 stddev:11.22 (15.0%) stddev-sans-first:11.57 04:56:56 INFO - PID 20428 | Values: 72.0 74.0 74.0 107.0 75.0 75.0 74.0 76.0 92.0 75.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:82.00 stddev:10.82 (13.2%) stddev-sans-first:11.33 04:56:56 INFO - PID 20428 | Values: 84.0 82.0 107.0 82.0 82.0 82.0 100.0 82.0 82.0 106.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:56:56 INFO - PID 20428 | Values: 113.0 114.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 114.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 04:56:56 INFO - PID 20428 | Values: 146.0 146.0 146.0 148.0 147.0 147.0 147.0 147.0 148.0 148.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:56:56 INFO - PID 20428 | Values: 94.0 95.0 94.0 93.0 94.0 93.0 94.0 93.0 93.0 93.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#8] json-parse-financial Cycles:10 Average:46.50 Median:47.00 stddev:0.53 (1.1%) stddev-sans-first:0.53 04:56:56 INFO - PID 20428 | Values: 46.0 46.0 46.0 47.0 47.0 47.0 47.0 46.0 46.0 47.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.44 04:56:56 INFO - PID 20428 | Values: 55.0 54.0 53.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.42 (3.1%) stddev-sans-first:2.55 04:56:56 INFO - PID 20428 | Values: 79.0 79.0 78.0 79.0 80.0 78.0 78.0 86.0 80.0 78.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:124.50 stddev:15.72 (12.6%) stddev-sans-first:16.66 04:56:56 INFO - PID 20428 | Values: 127.0 125.0 124.0 123.0 123.0 123.0 121.0 121.0 173.0 126.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:182.50 stddev:4.64 (2.5%) stddev-sans-first:4.58 04:56:56 INFO - PID 20428 | Values: 175.0 175.0 184.0 181.0 182.0 184.0 177.0 183.0 172.0 185.0 04:56:56 INFO - PID 20428 | 04:56:56 INFO - PID 20428 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.78 (2.7%) stddev-sans-first:1.79 04:56:56 INFO - PID 20428 | Values: 65.0 67.0 70.0 65.0 68.0 67.0 68.0 66.0 66.0 64.0 04:56:56 INFO - PID 20428 | -------- Summary: end -------- 04:56:56 INFO - PID 20428 | 04:56:58 INFO - TEST-INFO | 20428: exit 0 04:56:58 INFO - TEST-OK | kraken | took 59875ms 04:56:58 INFO - SUITE-END | took 1174s 04:56:58 INFO - Completed test suite (00:19:34) 04:56:58 INFO - javascript benchmark 04:56:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7662.857515702944, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.2296160402307, 3317.452620317648, 3322.1528510229887, 3336.182635254363, 3374.358871814355, 5745.0, 5859.44335288148, 5911.704414779255, 5920.378360272169, 5945.7027148642555, 5824.650520968745, 5880.558958078151, 5891.499222566087, 5898.88202235955, 5978.252718410199, 5196.1166601677805, 5199.038177937075, 5226.216067589854, 5260.658057226287, 5264.42091369951, 5220.216967454874, 5305.575553955674, 5342.412334643186, 5347.893042139155, 5349.358077030762, 5286.312779338661, 5361.142217245241, 5364.356277246717, 5401.810936617219, 5407.918881216785, 5123.257127716498, 5162.896742065138, 5185.896282074337, 5213.2701421800975, 5263.236830659571, 5229.2156176573435, 5245.86885327866, 5256.342957130359, 5278.868028299285, 5307.389650190239, 5832.795852145197, 5865.677387743673, 5875.735591898375, 5885.323187833411, 5892.116182572606, 6173.845653858644, 6283.434490895841, 6405.423511883906, 6410.166678331833, 6414.550981431302, 6366.586171898812, 6385.904211436832, 6425.45383642391, 6430.485561155143, 6490.675466226669, 5945.227120474311, 5948.226730525004, 5953.940460595382, 5986.850328741729, 6002.819915402545, 6380.808575742735, 6516.348365163446, 6517.217933847874, 6572.572782769104, 6577.934220657828, 6190.1952746142715, 6231.189945307081, 6237.968810156011, 6292.874142517216, 6315.621062736251, 6443.194600674916, 6447.323031081763, 6450.516211284079, 6452.451541619015, 6461.030845373231, 6351.333110023381, 6407.231132264158, 6408.775692850728, 6414.262359828586, 6415.037744338293, 6179.3202747697715, 6250.6874656267, 6280.811575652738, 6340.0, 6424.453921416732, 4784.976075119602, 4786.569208771228, 4792.041591681677, 4794.328793968847, 4814.325994360793, 4258.574142585717, 4259.5527469615245, 4261.509926358446, 4297.591728785823, 4312.180685669713, 5849.766009359578, 5982.0, 5983.760649574056, 5990.251218597676, 6005.099235114681, 6442.903356449657, 6445.065465507569, 6460.3862633049785, 6464.806055818239, 6466.805995820039, 6010.609310394811, 6036.728347224385, 6045.667488288186, 6056.121862329937, 6057.212562366864, 5440.0, 5537.307836520435, 5576.414476479911, 5580.302462192226, 5624.887502249932, 6446.774362897276, 6544.9672751635935, 6587.275399705933, 6593.637349945703, 6602.900956485752, 6346.587471814318, 6442.774502892376, 6443.96778016107, 6448.29068802422, 6456.709448074942, 6457.0637257596445, 6467.708953097216, 6588.07766912623, 6632.602043877383, 6744.291849355747, 6338.524610654312, 6346.333634968262, 6347.968260158855, 6348.523860710373, 6353.142325786144, 6377.585456945284, 6392.0731493934045, 6394.6482943436695, 6395.232572091379, 6433.903491447726, 6112.969435152796, 6144.446999769863, 6158.137860699416, 6182.258129024546, 6244.781432649836, 6198.101275315144, 6206.503479721701, 6218.5647004709235, 6245.0, 6248.875022499616, 6162.921488739363, 6165.198524191826, 6196.659183744938, 6204.751809927733, 6207.534434917489, 6143.232095988002, 6159.23009623797, 6171.84570385744, 6270.937290627217, 6296.307406185408, 6114.7536090578, 6120.782376608402, 6141.025769127022, 6142.324344322032, 6150.477209437069], "value": 5835.453385036149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.1176823116953, 823.0575990490887, 839.680921249925, 1144.5593446523087, 1160.3675996581862, 30552.541711874313, 38385.80807095964, 39346.80326598363, 39444.605553944486, 39470.40794388079, 41329.0, 41473.58526414735, 41686.79156604213, 41738.79130604343, 41757.58242417575, 5731.656100633975, 5855.121731740252, 7207.24323945986, 7325.743598974037, 7347.742829000986, 7216.567005979632, 7385.076865391826, 7388.0, 7396.704131834747, 7397.853332733435, 7444.851102977965, 7530.58581778002, 7535.284148005931, 7535.5478671279625, 7547.43394245431, 7436.330730234278, 7473.439492038092, 7488.288612581796, 7492.550446973145, 7505.549667019996, 7337.3763230125505, 7396.0, 7399.186089530147, 7399.260073992557, 7401.555906645618, 36381.81809090938, 36469.270614587556, 36593.63406365929, 36609.26781464383, 36615.63384366175, 3513.54323937889, 3549.893503194908, 3550.2721942001826, 3551.183227857607, 3551.3074950384685, 28459.146225613058, 28542.857285713646, 28646.570301445496, 28652.570211446844, 28705.425891482053, 3653.488511608377, 3660.432632941898, 3675.503806986076, 3698.3712768829364, 3706.1475860552223, 187241.0, 189402.58961155938, 189762.0, 190019.0, 190723.0, 47608.0, 47788.7610561945, 47845.65080444336, 47856.282155767694, 47952.52047479481, 50082.49917500851, 50151.24773128406, 50161.0, 50163.24755128676, 50202.74898625483, 13272.800907986388, 13342.466301348031, 13358.131721438076, 13373.732525349438, 13374.33128343579, 9415.952920235492, 9575.0, 10254.230932680079, 10272.075513203847, 11035.39305338214, 13270.668233294246, 13323.800142997863, 13367.598972030855, 13495.190288582717, 13541.0, 5444.292242008513, 5465.344158700981, 5491.945080549143, 5496.367917689437, 5509.090999984957, 1074.4949873559415, 1110.9224052668899, 1121.4448847820217, 1124.089487515099, 1125.234840308598, 26006.0, 26156.869215653798, 26335.473290534082, 26366.86816565905, 26432.339191520365, 1201.7776711308436, 1209.7580483903255, 1211.6425654431964, 1214.5566868093083, 1226.4480983557435, 13216.207027578184, 13459.327033648278, 13542.187468751907, 13602.93198534001, 13686.65783355424, 220051.0, 220840.0, 220955.0, 221555.0, 222503.0, 52567.73716131395, 52591.73704131455, 52608.73695631574, 52623.21065184025, 52714.0, 1445.580781573332, 1500.3098574655562, 1522.1932375840822, 1525.2907398059956, 1529.8852586055868, 23959.640605391283, 25075.623865642396, 25305.493890122463, 25336.493270134863, 25468.108616198344, 38667.0, 39058.21883562256, 39072.2185556293, 39106.6089339103, 39131.0, 200546.0, 201342.0, 201864.0, 202102.0, 202422.0, 29662.258443539085, 30206.54690179693, 33765.493517597744, 33861.49207761935, 33887.15282117967, 39755.0, 41514.962125947095, 41679.1664166721, 42187.0, 42304.78847605742, 27359.179224623294, 28469.0, 28612.713872861004, 29259.920634920636, 29482.410351792416, 28904.277393065342, 28949.855250723613, 29505.704942950295, 30109.548356774227, 30311.696883030887, 34973.0, 35450.11374715653, 35623.64376356307, 35828.462573060904, 35959.10102247465, 27926.72073279241, 27978.860105699343, 28500.287492812844, 28636.284092897844, 29336.0, 23763.762362376154, 24693.62959555572, 24805.875970620033, 24842.50314993654, 25117.120900769118], "value": 16612.661873593195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.3046855499756, 443.1358850242029, 445.67911104005105, 463.2888516127744, 467.1288047790869, 19179.712304315428, 20194.495137621547, 20868.582628347423, 20933.68599471007, 20981.0, 21153.894230528866, 21354.893225533888, 21371.6794248086, 22148.778512214874, 23306.06775728973, 5429.239906413095, 5590.413006634306, 5605.467480589358, 5607.607467477278, 5607.719614019283, 5455.727213639322, 5568.888622227553, 5619.522340601054, 5690.317161940573, 5748.97125514374, 5569.637973531728, 5593.0, 5593.664380137185, 5596.916046259309, 5618.91571626426, 5369.973150134244, 5622.409646987069, 5647.830565083054, 5669.9433005669825, 5679.432056794329, 5046.495350464961, 5153.0466863630345, 5156.871078223037, 5164.741762911877, 5164.8967020659375, 24827.87586062058, 25091.62362564563, 25124.623130653054, 25353.87323063391, 25467.61798573023, 2142.7964343387353, 2187.147012665062, 2188.7592364839857, 2192.583409152256, 2193.8354623403307, 15200.695986080327, 15559.22203889801, 15645.452409165624, 15713.842861571353, 15804.446844360507, 2133.967990480144, 2145.3159269973, 2174.4889950861534, 2191.0687957617947, 2211.579799838026, 89799.0, 102901.4854925728, 109038.0, 109178.45410772895, 110241.0, 12476.875231247572, 12680.175788573713, 12730.681732956566, 12844.229346239255, 12850.614481565568, 17709.468715938543, 17742.822571774115, 17840.732389014174, 17900.91049544744, 17954.102294885204, 8844.867326990101, 8898.955505222433, 8937.687180948766, 9032.36773425854, 9203.0, 8266.13205613414, 8279.130691277329, 8527.701530446404, 8534.402591818513, 8573.957130214309, 7841.568713720686, 7940.920590794018, 8165.305948994283, 8287.917120828835, 8341.24928756415, 2136.7863213678506, 2166.166026079939, 2190.1896298369707, 2201.8678879267295, 2279.452931296477, 1023.3706270643501, 1031.2265800649513, 1037.9481025948671, 1040.5005597313332, 1045.1482042135635, 20010.29963951255, 21721.239756608444, 23127.653085203397, 25701.0, 25892.352691182496, 1043.1341986151476, 1049.1554298789547, 1051.222095649214, 1063.7021633942509, 1072.2815713471837, 10957.945210273898, 11411.0, 11581.536738530533, 11640.94179529097, 11708.941455292668, 486230.0, 489651.0, 491566.0, 493201.0, 498717.0, 89723.0, 90183.54908225418, 91151.54424227969, 91248.54375728211, 92281.0, 1234.4321612058554, 1250.4623012104882, 1280.0271793436868, 1284.877936596022, 1286.2861112082696, 17781.73327400116, 17866.91066544659, 17935.461936141935, 18269.54326141857, 18442.170102345157, 45216.54783452255, 45353.546464534935, 45882.311765324215, 46616.7669161652, 46817.76591117022, 57988.0, 58348.12477812921, 58420.415795841494, 58610.413895860496, 59196.70401647964, 8902.0, 8929.419587726778, 9178.0, 9288.071192880929, 9320.300977426585, 13625.182489050689, 13740.175589464265, 13843.0, 13851.584452466443, 14169.645758856112, 11855.288682679067, 12552.686182845136, 12598.496060157491, 12808.871911281141, 12819.013052976803, 10928.180386470887, 11085.778284434427, 11211.9348661877, 11377.2604780689, 11486.483108259981, 12264.0, 12352.197107188003, 12494.125411221126, 12799.232046077264, 13544.864551354754, 9094.59074341643, 9108.225800807006, 9234.076592340713, 9455.676205331121, 9463.2429405646, 11199.496022678835, 12069.215500992408, 12152.0, 12395.132340736061, 12952.481900723866], "value": 10058.345684577784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.8336457942758, 1377.2562816079317, 1385.854485279045, 1387.1954266525415, 1395.6301580081276, 10712.143028557715, 11192.0, 11196.160287978393, 11198.608048718297, 11198.776024479515, 10830.296030757996, 10998.505067271972, 11367.431628418588, 11379.943100284487, 11388.658340249805, 2347.3779448446135, 2377.8097752179783, 2377.9167729129485, 2379.5003049359657, 2384.654225137354, 1953.3982134649593, 2221.278084622496, 2284.246198754415, 2284.4579908561736, 2285.8228012573454, 2009.1159889648582, 2167.5773224221284, 2285.451491642002, 2299.057386471547, 2301.022065622112, 2276.055436993646, 2283.22370394066, 2294.6902168207243, 2295.1507942061376, 2296.9893246971446, 2246.483308838976, 2254.2786308381324, 2271.057511132878, 2321.442853715096, 2329.650552417134, 11076.667699969013, 11112.666480022368, 11162.776744465147, 11164.441777911072, 11187.32876027441, 6265.780697675605, 6510.381513756186, 6516.706748196342, 6523.18460192476, 6537.496375833585, 3733.5706393764794, 3929.135590170158, 4065.227606754737, 4094.078832262747, 4123.752574845489, 1304.4912484131196, 1313.9211647301192, 1337.0774165825646, 1368.3773882883265, 1376.6833628265456, 16257.918710406373, 16418.17909104552, 16444.6711065778, 16458.83541164597, 16467.917660411742, 5259.789608415621, 5272.182811664198, 5347.304850369427, 5350.732463376816, 5492.945070549324, 12120.63638090841, 12163.087768417405, 12171.513139474499, 12184.08619353552, 12193.146479746332, 6492.707828147744, 6494.805155845333, 6498.3826536478955, 6500.447461965691, 6504.902426463606, 5617.634853734494, 5726.169705392695, 5795.797147099831, 6123.958926982424, 6129.601575897553, 4185.832566697298, 4302.82788688449, 4338.934915976263, 4339.804708788112, 4378.387025816388, 1184.2124986883798, 1233.1244816180433, 1240.107122871549, 1255.6609715376796, 1258.6790368456168, 758.1963119093779, 865.2904618213131, 880.2429910277157, 884.2263019857625, 894.5571941888807, 6216.285127210429, 6285.0, 6367.808965731036, 6503.6097834130105, 6585.374389432996, 949.0, 963.6675347005412, 978.8580655804868, 984.5274268351232, 1002.774375765447, 4096.40602112692, 4122.814473348706, 4134.24294674762, 4149.668026557868, 4151.045259590311, 14732.705345893022, 15133.167675777939, 15135.016223945408, 15141.772873406908, 15254.847451525564, 14390.28048597566, 14897.180655064076, 14908.329125189393, 14908.62728431798, 15104.773428398583, 8882.555872206363, 9108.089191080839, 9137.40606860552, 9171.81656366869, 9196.816063678689, 6734.653069386044, 7239.8914016290855, 7288.271172882669, 7362.9631851840395, 7370.410367170721, 12588.118831681695, 12834.935825320814, 13132.934335328262, 13167.67080822987, 13233.669158271121, 13140.60578182656, 13151.34243287851, 13154.0, 13161.868381316448, 13511.459541618226, 10294.588216471557, 10458.215633827342, 10586.417747023988, 10593.364398136137, 10596.152307815202, 10110.140638045554, 10354.844677329997, 10469.581216751549, 10804.519615972495, 10818.459077045958, 7480.588567628833, 8689.47863128189, 9066.456012639263, 9137.223336016514, 9294.302927280345, 8779.165979231962, 8976.910230897607, 8998.14517620825, 9128.406653567497, 9288.535573221177, 8468.068512463748, 8640.697575584825, 8653.913460865311, 8657.0, 8659.48043117415, 6089.360617135137, 6111.755529778759, 6132.2947860996555, 6164.6917654118015, 6284.4972402206795, 6370.968145159244, 6457.418832305115, 6471.482281417381, 6585.80242592723, 6753.831154221184], "value": 5330.23401261964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.2018320640257, 397.67390739593526, 414.52536845312113, 415.1261594343904, 417.0722908832147, 5895.557833162514, 5916.674582897939, 5918.763249470021, 5922.2597175353085, 5926.49624781893, 5601.8599535011645, 5739.483446489815, 5762.827115186541, 5798.942010579893, 5824.941750582493, 4393.582609652094, 4404.4054052702795, 4411.250087485119, 4425.7565833879125, 4431.512533621315, 4414.249577571804, 4417.933730994037, 4428.782084926639, 4442.378067070613, 4451.821927122911, 4345.196138714332, 4369.104333611618, 4375.67182461315, 4410.911781764379, 4415.315626077963, 4357.629601483894, 4362.389265502817, 4364.236258654722, 4385.605295523418, 4397.670174736875, 3844.519435070616, 3850.6919446444217, 3857.498525191707, 3869.438931354966, 3872.206197729459, 5547.5007249347345, 5625.240592519998, 5634.943650563524, 5638.548916086703, 5679.772809087673, 5145.819896303611, 5146.562542183881, 5152.639315247934, 5153.330067091291, 5164.354455693038, 6016.368281330441, 6153.569250152491, 6156.322804491502, 6172.84567885802, 6219.564630475868, 4266.717306241146, 4309.181255561464, 4312.8490502832565, 4328.264195086843, 4331.436913201295, 6213.1922850029205, 6272.18461599989, 6317.273513545909, 6401.263854656728, 6513.706883190221, 4392.38506609075, 4398.912021759547, 4402.3836662867225, 4403.185410699031, 4425.468943726709, 4493.191225579427, 4493.370928070073, 4494.415725955605, 4494.797734101973, 4504.572065653758, 5095.847124586268, 5137.922931156036, 5185.144451165515, 5193.974030129901, 5199.610029247821, 6175.722092505848, 6177.0, 6178.165947597017, 6187.535934804908, 6201.720922558496, 1497.91012539248, 1532.8926975111635, 1539.661274519604, 1540.091346105803, 1544.3282172255106, 1014.3812274512542, 1028.909356082555, 1032.9793404131876, 1037.2065369991963, 1038.4651904269308, 5981.192539007266, 5984.670843103584, 6002.219711437485, 6011.489023433057, 6033.5173186145, 6261.592996455216, 6268.749250030039, 6376.936230637727, 6396.872062558723, 6408.231012278557, 5989.371116032841, 6005.159277701126, 6027.939720602825, 6028.4272994065495, 6037.335893051761, 3354.8322583871195, 3354.865805367807, 3368.612609549884, 3371.511130886057, 3383.3233353329433, 6437.452816510556, 6719.832004199837, 6737.865242695217, 6742.190937087581, 6753.223379311344, 6549.0176473529355, 6571.047198156336, 6578.309277525791, 6578.618490117129, 6599.1091202687985, 6629.469642428594, 6692.498062645321, 6750.122484077038, 6781.254062053072, 6790.898136527956, 6431.260405053479, 6440.549161558646, 6449.3873082057125, 6451.774187903401, 6456.483481321577, 6093.939060609515, 6220.782272620437, 6303.2120984875055, 6357.315311442564, 6384.553081284265, 6533.379328963741, 6590.637514936533, 6675.432588229861, 6706.865862682816, 6737.562058466184, 4399.6920215584605, 4400.669949753717, 4409.7354158749295, 4420.933685994648, 4436.778161091868, 6277.654728989949, 6349.809505714836, 6429.4856411486035, 6436.613803171825, 6438.420542151229, 6196.504279657706, 6198.442140207403, 6216.751329946752, 6221.626702397871, 6249.593776404519, 6094.878102437838, 6131.754729810757, 6147.96926015385, 6198.132261483486, 6244.250689917239, 6187.969060154851, 6201.937980620136, 6213.726186131742, 6227.96886015567, 6230.127782110418, 6099.756009759737, 6254.687265636791, 6256.937430625636, 6277.780277690259, 6296.590721603081, 6058.151858739868, 6101.877962440815, 6105.504151482915, 6112.17485639433, 6117.204763380732], "value": 4696.179560460498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.9396642235046, 874.4141425245085, 877.1053525404088, 878.1745159550022, 887.378834815629, 15904.125273109974, 16295.0, 16410.34358625655, 16414.09722465264, 16434.589135271624, 16414.0, 16574.254158562864, 16623.251953662086, 16634.66730665389, 16665.333386664548, 989.159214667534, 996.9950150249239, 1008.0473952115254, 1010.2120346129993, 1011.3375738891039, 1043.2801367056707, 1045.1743122932874, 1045.8117538843005, 1046.0533217438192, 1046.6755305855172, 1068.1775033224412, 1079.0450451350532, 1079.20139097068, 1079.4872435593109, 1080.0819303591963, 1075.1936047964027, 1075.2150929821196, 1077.9353238805656, 1080.2384319055047, 1081.1026847716375, 789.3645615279697, 789.9012623422072, 790.095340834741, 790.4229912164095, 790.5809920741958, 17250.482485525456, 17397.826021739747, 17408.390706325343, 17662.735058974125, 17858.196381162878, 18436.262549498137, 18764.249430022785, 18875.0, 18983.145758440765, 19190.52023699405, 14419.0, 14870.182139982297, 15038.624034399118, 15052.32264548098, 15062.849371506254, 3234.886778962725, 3348.961821835239, 3385.221399078201, 3400.2009527760956, 3403.5745531808525, 77336.0, 77744.22255777483, 78735.0, 79315.60342198309, 80298.0, 14188.645283867985, 14524.854751452562, 14671.826253899875, 14687.485937992333, 14689.706205875822, 25021.62467562988, 26363.73636263651, 26989.325266868094, 27023.45953080967, 27043.0, 8334.374921880883, 8527.872081918777, 8539.359548033923, 8540.231379175904, 8563.614637341334, 4042.3532234842282, 4107.322291821875, 4131.442255295497, 4133.173365326947, 4134.421181034658, 5013.448520662724, 5139.254808052811, 5142.6400151989, 5146.845594632092, 5185.481451854785, 971.7862070344513, 977.130353984954, 979.3389462113046, 992.8858181309242, 997.4563862694848, 711.6477343714894, 714.5426926766874, 730.6273800361854, 736.6758626204453, 752.3604935804632, 11680.299182049104, 12427.192232504858, 12523.93738031304, 12746.553870614669, 12818.102732808615, 724.051492544768, 729.6971756721008, 731.989020164698, 736.006391371644, 739.981500462482, 5414.0, 5421.322334708161, 5795.478406943395, 5861.824145275648, 6059.242594675666, 72258.2774172262, 74442.62778686071, 75906.0, 77424.0, 83513.58243208866, 60650.09024864631, 60667.0, 63204.68397657982, 64789.0, 66670.66664666646, 61140.0, 61893.0, 62126.378736212966, 62178.0, 62816.685916570124, 11590.188686791844, 12509.74980500403, 12739.56031871371, 12911.35443227816, 13073.673158171121, 31648.841755791073, 32328.676713232566, 32329.35341293208, 33251.99999999903, 33428.997130086136, 54246.45753542572, 54745.1788223169, 55788.72105639446, 56309.155362668775, 57120.71439642775, 15234.0, 15485.612859678598, 15500.0, 15566.688666226839, 15684.76472852931, 17702.645947080728, 17976.0, 18052.638947221243, 18122.72815907736, 18135.27458901629, 15956.840431595536, 16467.835321647108, 16706.4152754653, 17288.567785804953, 17438.0, 16327.673446530765, 17026.404075857285, 17045.16509257253, 17057.744133837754, 17233.91383043127, 16342.428015019417, 16862.0, 17041.147942603067, 17068.573285667957, 17283.481495555152, 11855.229410088317, 12208.938955305166, 12219.0, 12343.629691109281, 12633.305168215837, 13327.267000315076, 13808.0, 13844.0, 14035.877129829792, 14046.508372206923], "value": 8294.365027124823, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 108.0, 110.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 120.0, 157.0, 117.0, 118.0, 117.0, 117.0, 139.0, 119.0], "value": 126.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 159.0, 160.0, 162.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 74.0, 107.0, 75.0, 75.0, 74.0, 76.0, 92.0, 75.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 107.0, 82.0, 82.0, 82.0, 100.0, 82.0, 82.0, 106.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 46.0, 47.0, 47.0, 47.0, 47.0, 46.0, 46.0, 47.0], "value": 46.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 80.0, 78.0, 78.0, 86.0, 80.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 124.0, 123.0, 123.0, 123.0, 121.0, 121.0, 173.0, 126.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 184.0, 181.0, 182.0, 184.0, 177.0, 183.0, 172.0, 185.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 70.0, 65.0, 68.0, 67.0, 68.0, 66.0, 66.0, 64.0], "value": 66.6, "unit": "score"}]}]} 04:56:58 INFO - Return code: 0 04:56:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:58 INFO - # TBPL SUCCESS # 04:56:58 INFO - Running post-action listener: _resource_record_post_action 04:56:58 INFO - [mozharness: 2017-05-11 11:56:58.759129Z] Finished run-tests step (success) 04:56:58 INFO - Running post-run listener: _resource_record_post_run 04:56:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356737024; Read time: 8; Write time: 197932 04:56:58 INFO - TinderboxPrint: CPU usage
12.9% 04:56:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:56:58 INFO - TinderboxPrint: I/O write bytes / time
356,737,024 / 197,932 04:56:58 INFO - TinderboxPrint: CPU idle
8,288.3 (87.1%) 04:56:58 INFO - TinderboxPrint: CPU user
1,183.5 (12.4%) 04:56:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:56:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 83873792; Read time: 0; Write time: 43264 04:56:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 265895936; Read time: 0; Write time: 152068 04:56:59 INFO - Running post-run listener: _upload_blobber_files 04:56:59 INFO - Blob upload gear active. 04:56:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:59 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 04:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:56:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:56:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:00 INFO - (blobuploader) - INFO - Done attempting. 04:57:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:01 INFO - (blobuploader) - INFO - Done attempting. 04:57:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:02 INFO - (blobuploader) - INFO - Done attempting. 04:57:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:05 INFO - (blobuploader) - INFO - Done attempting. 04:57:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:05 INFO - Return code: 0 04:57:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85fc894d7755f7fd5b6f25ed14b9926451d5e4716c8aaacc81d408742ef54fda92dc3a5e868f205c9b8770f57597587fbf9afc3f7ff78a2bb46769ff42fd791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af8831067b2f6e462891c2710d1bb40ae982a6bebf2d70bc891b2c720679bbe3bb23c4c3a6899a0aa67a235ec76593dcab81e856ddfb482be283cfe1f44f4325", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce00194018c4c13246ee96b5405c39c77c1a14ad880fee7fe3dcb07b8a0b60d3521dcaf64e1f8f1fc516af5c2fbe2d19c1f9bda4c8efabea74c17360cdecf72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da1c155d5b8e660022264a5947e0747dc0a1cb956fb31a328035d504fc53afd4ba0ca29ea5ce8dcdccc78e83f2f7efba48e331bc1961198b071728aa86d8968"} 04:57:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:05 INFO - Contents: 04:57:05 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85fc894d7755f7fd5b6f25ed14b9926451d5e4716c8aaacc81d408742ef54fda92dc3a5e868f205c9b8770f57597587fbf9afc3f7ff78a2bb46769ff42fd791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af8831067b2f6e462891c2710d1bb40ae982a6bebf2d70bc891b2c720679bbe3bb23c4c3a6899a0aa67a235ec76593dcab81e856ddfb482be283cfe1f44f4325", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce00194018c4c13246ee96b5405c39c77c1a14ad880fee7fe3dcb07b8a0b60d3521dcaf64e1f8f1fc516af5c2fbe2d19c1f9bda4c8efabea74c17360cdecf72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da1c155d5b8e660022264a5947e0747dc0a1cb956fb31a328035d504fc53afd4ba0ca29ea5ce8dcdccc78e83f2f7efba48e331bc1961198b071728aa86d8968"} 04:57:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:05 INFO - Copying logs to upload dir... 04:57:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.086425 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-11 04:57:05.238964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 04:57:05.243420) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85fc894d7755f7fd5b6f25ed14b9926451d5e4716c8aaacc81d408742ef54fda92dc3a5e868f205c9b8770f57597587fbf9afc3f7ff78a2bb46769ff42fd791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af8831067b2f6e462891c2710d1bb40ae982a6bebf2d70bc891b2c720679bbe3bb23c4c3a6899a0aa67a235ec76593dcab81e856ddfb482be283cfe1f44f4325", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce00194018c4c13246ee96b5405c39c77c1a14ad880fee7fe3dcb07b8a0b60d3521dcaf64e1f8f1fc516af5c2fbe2d19c1f9bda4c8efabea74c17360cdecf72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da1c155d5b8e660022264a5947e0747dc0a1cb956fb31a328035d504fc53afd4ba0ca29ea5ce8dcdccc78e83f2f7efba48e331bc1961198b071728aa86d8968"} build_url:https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/dJAozASwRJCoBPuu99lfuQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d85fc894d7755f7fd5b6f25ed14b9926451d5e4716c8aaacc81d408742ef54fda92dc3a5e868f205c9b8770f57597587fbf9afc3f7ff78a2bb46769ff42fd791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af8831067b2f6e462891c2710d1bb40ae982a6bebf2d70bc891b2c720679bbe3bb23c4c3a6899a0aa67a235ec76593dcab81e856ddfb482be283cfe1f44f4325", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce00194018c4c13246ee96b5405c39c77c1a14ad880fee7fe3dcb07b8a0b60d3521dcaf64e1f8f1fc516af5c2fbe2d19c1f9bda4c8efabea74c17360cdecf72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9da1c155d5b8e660022264a5947e0747dc0a1cb956fb31a328035d504fc53afd4ba0ca29ea5ce8dcdccc78e83f2f7efba48e331bc1961198b071728aa86d8968"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 04:57:05.268888) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:57:05.269246) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494502319.727528-1758794499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:57:05.355542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 04:57:05.355867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 04:57:05.356180) ========= ========= Total master_lag: 0.17 =========